builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0126 starttime: 1489702691.61 results: success (0) buildid: 20170316134821 builduid: 6706c0955cbc48ce944675fd54c46f34 revision: 39607304b774591fa6e32c4b06158d869483c312 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.614450) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.614900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.615174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.639993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.640432) ========= 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.Z1fIMLE9fo/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.p18CqtGyga/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-16 15:18:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.25M=0.001s 2017-03-16 15:18:11 (8.25 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.257052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.920821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.921131) ========= 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.Z1fIMLE9fo/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.p18CqtGyga/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.021360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:11.969060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-03-16 15:18:11.969407) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39607304b774591fa6e32c4b06158d869483c312 --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 39607304b774591fa6e32c4b06158d869483c312 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z1fIMLE9fo/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.p18CqtGyga/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-16 15:18:12,051 truncating revision to first 12 chars 2017-03-16 15:18:12,051 Setting DEBUG logging. 2017-03-16 15:18:12,052 attempt 1/10 2017-03-16 15:18:12,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39607304b774?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 15:18:12,705 unpacking tar archive at: mozilla-central-39607304b774/testing/mozharness/ program finished with exit code 0 elapsedTime=2.444384 ========= master_lag: 2.78 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-03-16 15:18:17.189236) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:17.193596) ========= script_repo_revision: 39607304b774591fa6e32c4b06158d869483c312 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:17.194005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:17.194284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 15:18:17.616705) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-16 15:18:17.617081) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z1fIMLE9fo/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.p18CqtGyga/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:18:17 INFO - MultiFileLogger online at 20170316 15:18:17 in /builds/slave/test 15:18:17 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 15:18:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:18:17 INFO - {'append_to_log': False, 15:18:17 INFO - 'base_work_dir': '/builds/slave/test', 15:18:17 INFO - 'blob_upload_branch': 'Firefox', 15:18:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:18:17 INFO - 'branch': 'Firefox', 15:18:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:17 INFO - 'config_files': ('talos/mac_config.py',), 15:18:17 INFO - 'default_actions': ('clobber', 15:18:17 INFO - 'read-buildbot-config', 15:18:17 INFO - 'download-and-extract', 15:18:17 INFO - 'populate-webroot', 15:18:17 INFO - 'create-virtualenv', 15:18:17 INFO - 'install', 15:18:17 INFO - 'run-tests'), 15:18:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:17 INFO - 'download_minidump_stackwalk': True, 15:18:17 INFO - 'download_symbols': 'ondemand', 15:18:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:17 INFO - 'gecko_profile': False, 15:18:17 INFO - 'gecko_profile_interval': 0, 15:18:17 INFO - 'installer_path': 'installer.exe', 15:18:17 INFO - 'log_level': 'info', 15:18:17 INFO - 'log_name': 'talos', 15:18:17 INFO - 'log_to_console': True, 15:18:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:18:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:18:17 INFO - 'opt_config_files': (), 15:18:17 INFO - 'pip_index': False, 15:18:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:18:17 INFO - 'cmd': ('bash', 15:18:17 INFO - '-c', 15:18:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:18:17 INFO - 'enabled': True, 15:18:17 INFO - 'halt_on_failure': False, 15:18:17 INFO - 'name': 'check_screen_resolution'},), 15:18:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:18:17 INFO - 'cmd': ('bash', 15:18:17 INFO - '-c', 15:18:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:18:17 INFO - 'enabled': True, 15:18:17 INFO - 'halt_on_failure': False, 15:18:17 INFO - 'name': 'check_screen_resolution'},), 15:18:17 INFO - 'run_cmd_checks_enabled': True, 15:18:17 INFO - 'suite': 'dromaeojs-e10s', 15:18:17 INFO - 'system_bits': '32', 15:18:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:17 INFO - 'title': 't-yosemite-r7-0126', 15:18:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:17 INFO - 'use_talos_json': True, 15:18:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:18:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:17 INFO - 'work_dir': 'build'} 15:18:17 INFO - [mozharness: 2017-03-16 22:18:17.822444Z] Running clobber step. 15:18:17 INFO - Running pre-action listener: _resource_record_pre_action 15:18:17 INFO - Running main action method: clobber 15:18:17 INFO - rmtree: /builds/slave/test/build 15:18:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:18:19 INFO - Running post-action listener: _resource_record_post_action 15:18:19 INFO - [mozharness: 2017-03-16 22:18:19.985514Z] Finished clobber step (success) 15:18:19 INFO - [mozharness: 2017-03-16 22:18:19.985643Z] Running read-buildbot-config step. 15:18:19 INFO - Running pre-action listener: _resource_record_pre_action 15:18:19 INFO - Running main action method: read_buildbot_config 15:18:19 INFO - Using buildbot properties: 15:18:19 INFO - { 15:18:19 INFO - "project": "", 15:18:19 INFO - "product": "firefox", 15:18:19 INFO - "script_repo_revision": "production", 15:18:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:18:19 INFO - "repository": "", 15:18:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:18:19 INFO - "buildid": "20170316134821", 15:18:19 INFO - "pgo_build": "False", 15:18:19 INFO - "basedir": "/builds/slave/test", 15:18:19 INFO - "buildnumber": 17, 15:18:19 INFO - "slavename": "t-yosemite-r7-0126", 15:18:19 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:18:19 INFO - "platform": "yosemite_r7", 15:18:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:18:19 INFO - "branch": "mozilla-central", 15:18:19 INFO - "repo_path": "mozilla-central", 15:18:19 INFO - "revision": "39607304b774591fa6e32c4b06158d869483c312", 15:18:19 INFO - "stage_platform": "macosx64", 15:18:19 INFO - "builduid": "6706c0955cbc48ce944675fd54c46f34", 15:18:19 INFO - "slavebuilddir": "test" 15:18:19 INFO - } 15:18:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:18:19 INFO - Running post-action listener: _resource_record_post_action 15:18:19 INFO - [mozharness: 2017-03-16 22:18:19.988952Z] Finished read-buildbot-config step (success) 15:18:19 INFO - [mozharness: 2017-03-16 22:18:19.989070Z] Running download-and-extract step. 15:18:19 INFO - Running pre-action listener: _resource_record_pre_action 15:18:19 INFO - Running main action method: download_and_extract 15:18:19 INFO - mkdir: /builds/slave/test/build/tests 15:18:19 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')]} 15:18:19 INFO - trying https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:18:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:18:21 INFO - Downloaded 1325 bytes. 15:18:21 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:18:21 INFO - Using the following test package requirements: 15:18:21 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:18:21 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:18:21 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:18:21 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:18:21 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'jsshell-mac.zip'], 15:18:21 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:18:21 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:18:21 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:18:21 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:18:21 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:18:21 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:18:21 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:18:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:18:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:18:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:18:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:18:22 INFO - Expected file size: 52472680 15:18:22 INFO - Obtained file size: 52472680 15:18:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:18:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:18:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:18:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:18:40 INFO - Expected file size: 52472680 15:18:40 INFO - Obtained file size: 52472680 15:18:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:18:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:18:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:18:56 INFO - Expected file size: 14404452 15:18:56 INFO - Obtained file size: 14404452 15:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:57 INFO - trying https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:18:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:18:59 INFO - Downloaded 75073670 bytes. 15:18:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:18:59 INFO - mkdir: /builds/slave/test/properties 15:18:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:59 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:59 INFO - Contents: 15:18:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:18:59 INFO - Running post-action listener: _resource_record_post_action 15:18:59 INFO - Running post-action listener: set_extra_try_arguments 15:18:59 INFO - [mozharness: 2017-03-16 22:18:59.990124Z] Finished download-and-extract step (success) 15:18:59 INFO - [mozharness: 2017-03-16 22:18:59.990249Z] Running populate-webroot step. 15:18:59 INFO - Running pre-action listener: _resource_record_pre_action 15:18:59 INFO - Running main action method: populate_webroot 15:18:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:18:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:18:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:18:59 INFO - '--tppagecycles', 15:18:59 INFO - '7'], 15:18:59 INFO - 'tests': ['tsvgm']}}, 15:18:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:18:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:18:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:18:59 INFO - 'talos_options': ['--disable-e10s'], 15:18:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:19:00 INFO - 'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['damp', 'tps']}, 15:19:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:19:00 INFO - 'tests': ['damp', 'tps']}, 15:19:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['dromaeo_dom']}, 15:19:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['basic_compositor_video']}, 15:19:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:19:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['a11yr', 15:19:00 INFO - 'ts_paint', 15:19:00 INFO - 'tpaint', 15:19:00 INFO - 'sessionrestore', 15:19:00 INFO - 'sessionrestore_no_auto_restore', 15:19:00 INFO - 'tabpaint']}, 15:19:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:19:00 INFO - 'ts_paint', 15:19:00 INFO - 'tpaint', 15:19:00 INFO - 'sessionrestore', 15:19:00 INFO - 'sessionrestore_no_auto_restore', 15:19:00 INFO - 'tabpaint']}, 15:19:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:19:00 INFO - 'ts_paint', 15:19:00 INFO - 'tpaint', 15:19:00 INFO - 'sessionrestore', 15:19:00 INFO - 'sessionrestore_no_auto_restore', 15:19:00 INFO - 'tabpaint']}, 15:19:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:19:00 INFO - 'ts_paint', 15:19:00 INFO - 'tpaint', 15:19:00 INFO - 'sessionrestore', 15:19:00 INFO - 'sessionrestore_no_auto_restore', 15:19:00 INFO - 'tabpaint']}, 15:19:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['a11yr', 15:19:00 INFO - 'ts_paint', 15:19:00 INFO - 'tpaint', 15:19:00 INFO - 'sessionrestore', 15:19:00 INFO - 'sessionrestore_no_auto_restore', 15:19:00 INFO - 'tabpaint']}, 15:19:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['a11yr', 15:19:00 INFO - 'ts_paint', 15:19:00 INFO - 'tpaint', 15:19:00 INFO - 'sessionrestore', 15:19:00 INFO - 'sessionrestore_no_auto_restore', 15:19:00 INFO - 'tabpaint']}, 15:19:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['tsvgx', 15:19:00 INFO - 'tsvgr_opacity', 15:19:00 INFO - 'tart', 15:19:00 INFO - 'tscrollx', 15:19:00 INFO - 'cart', 15:19:00 INFO - 'tsvg_static']}, 15:19:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:19:00 INFO - 'tsvgr_opacity', 15:19:00 INFO - 'tart', 15:19:00 INFO - 'tscrollx', 15:19:00 INFO - 'cart', 15:19:00 INFO - 'tsvg_static']}, 15:19:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:19:00 INFO - 'talos_options': ['--disable-e10s'], 15:19:00 INFO - 'tests': ['tp5o']}, 15:19:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:19:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:19:00 INFO - 'talos_options': ['--disable-e10s', 15:19:00 INFO - '--xperf_path', 15:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:00 INFO - 'tests': ['tp5n']}, 15:19:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:19:00 INFO - 'talos_options': ['--xperf_path', 15:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:00 INFO - 'tests': ['tp5n']}}, 15:19:00 INFO - 'talos.zip': {'path': '', 15:19:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:19:00 INFO - Running post-action listener: _resource_record_post_action 15:19:00 INFO - [mozharness: 2017-03-16 22:19:00.009002Z] Finished populate-webroot step (success) 15:19:00 INFO - [mozharness: 2017-03-16 22:19:00.009137Z] Running create-virtualenv step. 15:19:00 INFO - Running pre-action listener: _resource_record_pre_action 15:19:00 INFO - Running main action method: create_virtualenv 15:19:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:00 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 15:19:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:19:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:00 INFO - Using real prefix '/tools/python27' 15:19:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:00 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:03 INFO - Installing pip.................done. 15:19:03 INFO - Return code: 0 15:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:19:03 INFO - Reading from file tmpfile_stdout 15:19:03 INFO - Output received: 15:19:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:19:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19: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', 'pip>=1.5'] in /builds/slave/test/build 15:19: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 pip>=1.5 15:19:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:03 INFO - 'HOME': '/Users/cltbld', 15:19:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:03 INFO - 'LOGNAME': 'cltbld', 15:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:03 INFO - 'MOZ_NO_REMOTE': '1', 15:19:03 INFO - 'NO_EM_RESTART': '1', 15:19:03 INFO - 'PAGER': '/bin/cat', 15:19:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:03 INFO - 'PWD': '/builds/slave/test', 15:19:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:03 INFO - 'SHELL': '/bin/bash', 15:19:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:03 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:03 INFO - 'USER': 'cltbld', 15:19:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:03 INFO - 'XPC_FLAGS': '0x0', 15:19:03 INFO - 'XPC_SERVICE_NAME': '0', 15:19:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:04 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 15:19:04 INFO - Cleaning up... 15:19:04 INFO - Return code: 0 15:19:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:19:04 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')]} 15:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:04 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')]} 15:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:04 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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:04 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 15:19:04 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 15:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:04 INFO - 'HOME': '/Users/cltbld', 15:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:04 INFO - 'LOGNAME': 'cltbld', 15:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:04 INFO - 'MOZ_NO_REMOTE': '1', 15:19:04 INFO - 'NO_EM_RESTART': '1', 15:19:04 INFO - 'PAGER': '/bin/cat', 15:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:04 INFO - 'PWD': '/builds/slave/test', 15:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:04 INFO - 'SHELL': '/bin/bash', 15:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:04 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:04 INFO - 'USER': 'cltbld', 15:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:04 INFO - 'XPC_FLAGS': '0x0', 15:19:04 INFO - 'XPC_SERVICE_NAME': '0', 15:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:04 INFO - Downloading/unpacking psutil>=3.1.1 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:07 INFO - Installing collected packages: psutil 15:19:07 INFO - Running setup.py install for psutil 15:19:08 INFO - building 'psutil._psutil_osx' extension 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 INFO - building 'psutil._psutil_posix' extension 15:19:08 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 15:19:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:19:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:19:08 INFO - ^ 15:19:08 INFO - 1 warning generated. 15:19:08 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 15:19:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:08 INFO - Successfully installed psutil 15:19:08 INFO - Cleaning up... 15:19:08 INFO - Return code: 0 15:19:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19:08 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')]} 15:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:09 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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:09 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 15:19:09 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 15:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:09 INFO - 'HOME': '/Users/cltbld', 15:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:09 INFO - 'LOGNAME': 'cltbld', 15:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:09 INFO - 'MOZ_NO_REMOTE': '1', 15:19:09 INFO - 'NO_EM_RESTART': '1', 15:19:09 INFO - 'PAGER': '/bin/cat', 15:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:09 INFO - 'PWD': '/builds/slave/test', 15:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:09 INFO - 'SHELL': '/bin/bash', 15:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:09 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:09 INFO - 'USER': 'cltbld', 15:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:09 INFO - 'XPC_FLAGS': '0x0', 15:19:09 INFO - 'XPC_SERVICE_NAME': '0', 15:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:13 INFO - Installing collected packages: mozsystemmonitor 15:19:13 INFO - Running setup.py install for mozsystemmonitor 15:19:13 INFO - Successfully installed mozsystemmonitor 15:19:13 INFO - Cleaning up... 15:19:13 INFO - Return code: 0 15:19:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:19:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:13 INFO - 'HOME': '/Users/cltbld', 15:19:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:13 INFO - 'LOGNAME': 'cltbld', 15:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:13 INFO - 'MOZ_NO_REMOTE': '1', 15:19:13 INFO - 'NO_EM_RESTART': '1', 15:19:13 INFO - 'PAGER': '/bin/cat', 15:19:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:13 INFO - 'PWD': '/builds/slave/test', 15:19:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:13 INFO - 'SHELL': '/bin/bash', 15:19:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:13 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:13 INFO - 'USER': 'cltbld', 15:19:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:13 INFO - 'XPC_FLAGS': '0x0', 15:19:13 INFO - 'XPC_SERVICE_NAME': '0', 15:19:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:13 INFO - Downloading/unpacking jsonschema==2.5.1 15:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:16 INFO - warning: no files found matching '*.txt' 15:19:16 INFO - no previously-included directories found matching 'build' 15:19:16 INFO - no previously-included directories found matching 'dist' 15:19:16 INFO - no previously-included directories found matching '.git*' 15:19:16 INFO - Installing collected packages: jsonschema, functools32 15:19:16 INFO - Running setup.py install for functools32 15:19:16 INFO - warning: no files found matching '*.txt' 15:19:16 INFO - no previously-included directories found matching 'build' 15:19:16 INFO - no previously-included directories found matching 'dist' 15:19:16 INFO - no previously-included directories found matching '.git*' 15:19:17 INFO - Successfully installed jsonschema functools32 15:19:17 INFO - Cleaning up... 15:19:17 INFO - Return code: 0 15:19:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:17 INFO - 'HOME': '/Users/cltbld', 15:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:17 INFO - 'LOGNAME': 'cltbld', 15:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:17 INFO - 'MOZ_NO_REMOTE': '1', 15:19:17 INFO - 'NO_EM_RESTART': '1', 15:19:17 INFO - 'PAGER': '/bin/cat', 15:19:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:17 INFO - 'PWD': '/builds/slave/test', 15:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:17 INFO - 'SHELL': '/bin/bash', 15:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:17 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:17 INFO - 'USER': 'cltbld', 15:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:17 INFO - 'XPC_FLAGS': '0x0', 15:19:17 INFO - 'XPC_SERVICE_NAME': '0', 15:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:19:17 INFO - Cleaning up... 15:19:17 INFO - Return code: 0 15:19:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:17 INFO - 'HOME': '/Users/cltbld', 15:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:17 INFO - 'LOGNAME': 'cltbld', 15:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:17 INFO - 'MOZ_NO_REMOTE': '1', 15:19:17 INFO - 'NO_EM_RESTART': '1', 15:19:17 INFO - 'PAGER': '/bin/cat', 15:19:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:17 INFO - 'PWD': '/builds/slave/test', 15:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:17 INFO - 'SHELL': '/bin/bash', 15:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:17 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:17 INFO - 'USER': 'cltbld', 15:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:17 INFO - 'XPC_FLAGS': '0x0', 15:19:17 INFO - 'XPC_SERVICE_NAME': '0', 15:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:17 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 15:19:17 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 15:19:17 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 15:19:17 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 15:19:17 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 15:19:17 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 15:19:20 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:21 INFO - Downloading docopt-0.6.1.tar.gz 15:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:21 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:21 INFO - Running setup.py install for blobuploader 15:19:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:21 INFO - Running setup.py install for requests 15:19:22 INFO - Running setup.py install for docopt 15:19:22 INFO - Successfully installed blobuploader requests docopt 15:19:22 INFO - Cleaning up... 15:19:22 INFO - Return code: 0 15:19:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:22 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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:22 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 15:19:22 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 15:19:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:22 INFO - 'HOME': '/Users/cltbld', 15:19:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:22 INFO - 'LOGNAME': 'cltbld', 15:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:22 INFO - 'MOZ_NO_REMOTE': '1', 15:19:22 INFO - 'NO_EM_RESTART': '1', 15:19:22 INFO - 'PAGER': '/bin/cat', 15:19:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:22 INFO - 'PWD': '/builds/slave/test', 15:19:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:22 INFO - 'SHELL': '/bin/bash', 15:19:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:22 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:22 INFO - 'USER': 'cltbld', 15:19:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:22 INFO - 'XPC_FLAGS': '0x0', 15:19:22 INFO - 'XPC_SERVICE_NAME': '0', 15:19:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:22 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-MW7Xhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:22 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-M2_J4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:22 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-z_EIjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:22 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-heGRXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Hh21xM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-mvbg0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-CIREkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-gTvbO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-SlzWlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_BB79d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4TLQ4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-mRCpeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-DSDd4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-S8Vrv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VYvZRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-vFdo2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-0eDtOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:24 INFO - Running setup.py install for manifestparser 15:19:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:24 INFO - Running setup.py install for mozcrash 15:19:24 INFO - Running setup.py install for mozdebug 15:19:24 INFO - Running setup.py install for mozdevice 15:19:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Running setup.py install for mozfile 15:19:25 INFO - Running setup.py install for mozhttpd 15:19:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Running setup.py install for mozinfo 15:19:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Running setup.py install for mozInstall 15:19:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Running setup.py install for mozleak 15:19:25 INFO - Running setup.py install for mozlog 15:19:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Running setup.py install for moznetwork 15:19:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Running setup.py install for mozprocess 15:19:26 INFO - Running setup.py install for mozprofile 15:19:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Running setup.py install for mozrunner 15:19:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Running setup.py install for mozscreenshot 15:19:26 INFO - Running setup.py install for moztest 15:19:26 INFO - Running setup.py install for mozversion 15:19:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:26 INFO - Cleaning up... 15:19:26 INFO - Return code: 0 15:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:26 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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:26 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 15:19:26 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 15:19:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:26 INFO - 'HOME': '/Users/cltbld', 15:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:27 INFO - 'LOGNAME': 'cltbld', 15:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:27 INFO - 'MOZ_NO_REMOTE': '1', 15:19:27 INFO - 'NO_EM_RESTART': '1', 15:19:27 INFO - 'PAGER': '/bin/cat', 15:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:27 INFO - 'PWD': '/builds/slave/test', 15:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:27 INFO - 'SHELL': '/bin/bash', 15:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:27 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:27 INFO - 'USER': 'cltbld', 15:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:27 INFO - 'XPC_FLAGS': '0x0', 15:19:27 INFO - 'XPC_SERVICE_NAME': '0', 15:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-oy3Wgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:27 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)) 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-H4V5vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-hWCkpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:27 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)) 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-HKod3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-IZ3bb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:27 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)) 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-QBER6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:27 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)) 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-l4sijy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:27 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)) 15:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-hKU0wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9lRDlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ryORwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9VMUqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-qgvWhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-bIosqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Ds2QWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-CUbjz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5_514V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-nddUCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:29 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)) 15:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:19:29 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)) 15:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:19:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:31 INFO - Downloading blessings-1.6.tar.gz 15:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:31 INFO - Installing collected packages: blessings 15:19:31 INFO - Running setup.py install for blessings 15:19:31 INFO - Successfully installed blessings 15:19:31 INFO - Cleaning up... 15:19:32 INFO - Return code: 0 15:19:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:32 INFO - Reading from file tmpfile_stdout 15:19:32 INFO - Current package versions: 15:19:32 INFO - blessings == 1.6 15:19:32 INFO - blobuploader == 1.2.4 15:19:32 INFO - docopt == 0.6.1 15:19:32 INFO - functools32 == 3.2.3-2 15:19:32 INFO - jsonschema == 2.5.1 15:19:32 INFO - manifestparser == 1.1 15:19:32 INFO - mozInstall == 1.12 15:19:32 INFO - mozcrash == 1.0 15:19:32 INFO - mozdebug == 0.1 15:19:32 INFO - mozdevice == 0.49 15:19:32 INFO - mozfile == 1.2 15:19:32 INFO - mozhttpd == 0.7 15:19:32 INFO - mozinfo == 0.9 15:19:32 INFO - mozleak == 0.1 15:19:32 INFO - mozlog == 3.4 15:19:32 INFO - moznetwork == 0.27 15:19:32 INFO - mozprocess == 0.25 15:19:32 INFO - mozprofile == 0.28 15:19:32 INFO - mozrunner == 6.13 15:19:32 INFO - mozscreenshot == 0.1 15:19:32 INFO - mozsystemmonitor == 0.3 15:19:32 INFO - moztest == 0.8 15:19:32 INFO - mozversion == 1.4 15:19:32 INFO - psutil == 3.1.1 15:19:32 INFO - requests == 1.2.3 15:19:32 INFO - wsgiref == 0.1.2 15:19:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:32 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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:32 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 15:19:32 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 15:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:32 INFO - 'HOME': '/Users/cltbld', 15:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:32 INFO - 'LOGNAME': 'cltbld', 15:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:32 INFO - 'MOZ_NO_REMOTE': '1', 15:19:32 INFO - 'NO_EM_RESTART': '1', 15:19:32 INFO - 'PAGER': '/bin/cat', 15:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:32 INFO - 'PWD': '/builds/slave/test', 15:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:32 INFO - 'SHELL': '/bin/bash', 15:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:32 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:32 INFO - 'USER': 'cltbld', 15:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:32 INFO - 'XPC_FLAGS': '0x0', 15:19:32 INFO - 'XPC_SERVICE_NAME': '0', 15:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 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)) 15:19:32 INFO - Cleaning up... 15:19:32 INFO - Return code: 0 15:19:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:32 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 0x1102aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde11cad0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, '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.Z1fIMLE9fo/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.p18CqtGyga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 15:19:32 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 15:19:32 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 15:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:32 INFO - 'HOME': '/Users/cltbld', 15:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:32 INFO - 'LOGNAME': 'cltbld', 15:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:32 INFO - 'MOZ_NO_REMOTE': '1', 15:19:32 INFO - 'NO_EM_RESTART': '1', 15:19:32 INFO - 'PAGER': '/bin/cat', 15:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:32 INFO - 'PWD': '/builds/slave/test', 15:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:32 INFO - 'SHELL': '/bin/bash', 15:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:32 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:32 INFO - 'USER': 'cltbld', 15:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:32 INFO - 'XPC_FLAGS': '0x0', 15:19:32 INFO - 'XPC_SERVICE_NAME': '0', 15:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:19:32 INFO - Cleaning up... 15:19:32 INFO - Return code: 0 15:19:32 INFO - Running post-action listener: _resource_record_post_action 15:19:32 INFO - Running post-action listener: _start_resource_monitoring 15:19:32 INFO - Starting resource monitoring. 15:19:32 INFO - [mozharness: 2017-03-16 22:19:32.949659Z] Finished create-virtualenv step (success) 15:19:32 INFO - [mozharness: 2017-03-16 22:19:32.950591Z] Running install step. 15:19:32 INFO - Running pre-action listener: _resource_record_pre_action 15:19:32 INFO - Running main action method: install 15:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:33 INFO - Reading from file tmpfile_stdout 15:19:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:33 INFO - Reading from file tmpfile_stdout 15:19:33 INFO - Output received: 15:19:33 INFO - Usage: mozinstall [options] installer 15:19:33 INFO - Options: 15:19:33 INFO - -h, --help show this help message and exit 15:19:33 INFO - -d DEST, --destination=DEST 15:19:33 INFO - Directory to install application into. [default: 15:19:33 INFO - "/builds/slave/test"] 15:19:33 INFO - --app=APP Application being installed. [default: firefox] 15:19:33 INFO - mkdir: /builds/slave/test/build/application 15:19:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:19:53 INFO - Reading from file tmpfile_stdout 15:19:53 INFO - Output received: 15:19:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:19:53 INFO - Running post-action listener: _resource_record_post_action 15:19:53 INFO - [mozharness: 2017-03-16 22:19:53.385723Z] Finished install step (success) 15:19:53 INFO - [mozharness: 2017-03-16 22:19:53.385867Z] Running run-tests step. 15:19:53 INFO - Running pre-action listener: _resource_record_pre_action 15:19:53 INFO - Running main action method: run_tests 15:19:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:19:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:19:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:19:53 INFO - 2017-03-16 15:19:53.400 screenresolution[1901:14895] starting screenresolution argv=screenresolution get 15:19:53 INFO - 2017-03-16 15:19:53.403 screenresolution[1901:14895] Display 0: 1600x1200x32@60 15:19:53 INFO - 2017-03-16 15:19:53.408 screenresolution[1902:14898] starting screenresolution argv=screenresolution list 15:19:53 INFO - Available Modes on Display 0 15:19:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:19:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:19:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:19:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:19:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:19:53 INFO - Intel Iris: 15:19:53 INFO - Chipset Model: Intel Iris 15:19:53 INFO - Type: GPU 15:19:53 INFO - Bus: Built-In 15:19:53 INFO - VRAM (Dynamic, Max): 1536 MB 15:19:53 INFO - Vendor: Intel (0x8086) 15:19:53 INFO - Device ID: 0x0a2e 15:19:53 INFO - Revision ID: 0x0009 15:19:53 INFO - Displays: 15:19:53 INFO - Display: 15:19:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:19:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:19:53 INFO - Display Serial Number: 1600x1200 60 15:19:53 INFO - Main Display: Yes 15:19:53 INFO - Mirror: Off 15:19:53 INFO - Online: Yes 15:19:53 INFO - Rotation: Supported 15:19:53 INFO - Return code: 0 15:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:53 INFO - Python 2.7.3 15:19:53 INFO - Return code: 0 15:19:53 INFO - grabbing minidump binary from tooltool 15:19:53 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')]} 15:19:53 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 0x110088d30>, '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 0x10ffafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11007dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:53 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 15:19:53 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 15:19:53 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 15:19:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:53 INFO - Return code: 0 15:19:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:19:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:53 INFO - ENV: RUST_BACKTRACE is now 1 15:19:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:19:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:53 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/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 15:19:53 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/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --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 15:19:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z1fIMLE9fo/Render', 15:19:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:53 INFO - 'HOME': '/Users/cltbld', 15:19:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:53 INFO - 'LOGNAME': 'cltbld', 15:19:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:53 INFO - 'MOZ_NO_REMOTE': '1', 15:19:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:53 INFO - 'NO_EM_RESTART': '1', 15:19:53 INFO - 'PAGER': '/bin/cat', 15:19:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:53 INFO - 'PWD': '/builds/slave/test', 15:19:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:53 INFO - 'RUST_BACKTRACE': '1', 15:19:53 INFO - 'SHELL': '/bin/bash', 15:19:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p18CqtGyga/Listeners', 15:19:53 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 15:19:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:53 INFO - 'USER': 'cltbld', 15:19:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:53 INFO - 'XPC_FLAGS': '0x0', 15:19:53 INFO - 'XPC_SERVICE_NAME': '0', 15:19:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:53 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/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 15:19:53 INFO - mozversion application_buildid: 20170316134821 15:19:53 INFO - mozversion application_changeset: 39607304b774591fa6e32c4b06158d869483c312 15:19:53 INFO - mozversion application_display_name: Nightly 15:19:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:53 INFO - mozversion application_name: Firefox 15:19:53 INFO - mozversion application_remotingname: firefox 15:19:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:19:53 INFO - mozversion application_vendor: Mozilla 15:19:53 INFO - mozversion application_version: 55.0a1 15:19:53 INFO - mozversion platform_buildid: 20170316134821 15:19:53 INFO - mozversion platform_changeset: 39607304b774591fa6e32c4b06158d869483c312 15:19:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:19:53 INFO - mozversion platform_version: 55.0a1 15:19:53 INFO - using testdate: 1489702793 15:19:53 INFO - actual date: 1489702793 15:19:53 INFO - starting webserver on 'localhost:49373' 15:19:53 INFO - SUITE-START | Running 2 tests 15:19:53 INFO - TEST-START | dromaeo_css 15:19:53 INFO - operating with platform_type : mac_ 15:19:53 INFO - Initialising browser for dromaeo_css test... 15:19:54 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpgixGt5/profile http://localhost:49373/getInfo.html) 15:19:56 INFO - PID 1912 | 2017-03-16 15:19:56.645 plugin-container[1914:15063] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x483f, name = 'com.apple.tsm.portname' 15:19:56 INFO - PID 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:19:56 INFO - PID 1912 | 2017-03-16 15:19:56.648 plugin-container[1914:15063] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 15:19:56 INFO - PID 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:19:56 INFO - PID 1912 | 2017-03-16 15:19:56.648 plugin-container[1914:15063] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:19:56 INFO - PID 1912 | __metrics Screen width/height:1600/1200 15:19:56 INFO - PID 1912 | colorDepth:24 15:19:56 INFO - PID 1912 | Browser inner width/height: 1024/689 15:19:56 INFO - PID 1912 | __metrics 15:19:56 ERROR - PID 1912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 15:19:57 INFO - TEST-INFO | 1912: exit 0 15:19:57 INFO - Browser initialized. 15:19:57 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:57 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpgixGt5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:00 INFO - PID 1915 | 2017-03-16 15:20:00.079 plugin-container[1916:15185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453b, name = 'com.apple.tsm.portname' 15:20:00 INFO - PID 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:20:00 INFO - PID 1915 | 2017-03-16 15:20:00.079 plugin-container[1916:15185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.CFPasteboardClient' 15:20:00 INFO - PID 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:20:00 INFO - PID 1915 | 2017-03-16 15:20:00.079 plugin-container[1916:15185] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:20:09 INFO - PID 1915 | RSS: Main: 227753984 15:20:09 INFO - PID 1915 | 15:23:13 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49373/tests/dromaeo/cssquery-ext.html) 15:23:15 INFO - PID 1915 | RSS: Main: 250789888 15:23:15 INFO - PID 1915 | 15:24:57 INFO - PID 1915 | ************************* 15:24:57 INFO - PID 1915 | A coding exception was thrown and uncaught in a Task. 15:24:57 INFO - PID 1915 | 15:24:57 ERROR - PID 1915 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:24:57 INFO - PID 1915 | Full stack: 15:24:57 INFO - PID 1915 | ************************* 15:26:18 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-ext.html (next: http://localhost:49373/tests/dromaeo/cssquery-jquery.html) 15:26:18 INFO - PID 1915 | RSS: Main: 259108864 15:26:18 INFO - PID 1915 | 15:29:20 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49373/tests/dromaeo/cssquery-mootools.html) 15:29:21 INFO - PID 1915 | RSS: Main: 271462400 15:29:21 INFO - PID 1915 | 15:32:23 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49373/tests/dromaeo/cssquery-prototype.html) 15:32:23 INFO - PID 1915 | RSS: Main: 263315456 15:32:23 INFO - PID 1915 | 15:35:26 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49373/tests/dromaeo/cssquery-yui.html) 15:35:27 INFO - PID 1915 | RSS: Main: 273420288 15:35:27 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49373/tests/dromaeo/cssquery-yui.html (next: http://localhost:49373/tests/dromaeo/cssquery-dojo.html) 15:38:30 INFO - PID 1915 | RSS: Main: 267370496 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | __start_tp_report 15:38:30 INFO - PID 1915 | _x_x_mozilla_page_load 15:38:30 INFO - PID 1915 | _x_x_mozilla_page_load_details 15:38:30 INFO - PID 1915 | |i|pagename|runs| 15:38:30 INFO - PID 1915 | |0;dojo.html;3426.7087297579706;3452.6374730653297;3453.877489815807;3458.982705086474;3470.6355832637573;5864.354920958702;5993.280806303244;6024.728887200075;6065.423784740454;6069.78755743549;5143;5837.416258374171;5983.401659834014;6012.909806352908;6100.725467353968;5376.086065368897;5429.321334833146;5463.043967305725;5481.945180548183;5500.614956953015;5395.81114660987;5450.972745136269;5512.972435137819;5521.917171242435;5553.139263414178;5372.0330340538685;5408.594355423359;5435.076037073707;5466.508014278734;5482.342118945732;5417.241586177938;5418.45815418455;5430.402655707869;5446.809361672362;5491.176323551459;5380.838574842722;5387.78448862045;5399.487048730364;5419.295491586108;5478.178273259004;5777.480026797609;5808.1578171165365;5848.1520179574145;5983.551233657493;6006.399360064002;5873.706314684291;5895.380984996599;6268.498520118425;6358.713857876407;6376.649284289362;6371.872562548723;6375.93624063758;6423.036544518313;6428.228612566475;6440.323766004596;5060.342155519759;5956.106584012433;6028.849278768066;6066.848328791815;6098.57309988301;6322.399372059647;6420.871582568322;6490.870182596416;6541.705623246965;6556.934430655632;6192.195014648067;6212.192414986113;6253.593516421418;6287.779927702509;6313.210848643919;6300.180976473029;6415.903761443582;6419.646919419383;6420.261669907927;6439.452646525004;6346.238451385863;6359.046143078483;6372.426481616677;6372.968135159294;6436.098946147543;6237;6261.436470717657;6290.654014029181;6311.936880631227;6321.525885558602;5164.2770012198325;5176.171812509981;5181.4300426953005;5185.22221666753;5217.608679349064;4002.4996875390575;4610;4613.723176609415;4616.722996620214;4662.557057079572;5298.655587386807;5922.170896074553;6039.818805435844;6220.471259942956;6238.625682459067;6221.875562488815;6296.811095667137;6416.358364163546;6417.197850268716;6455.580387274906;6158;6205.410486003822;6219.129321894939;6227;6227.314995350508;5658.773649054074;5714.342850572154;5723.570732195102;5746.9712651436475;5758.683272419973;6432.421082102446;6473.805785826433;6636.933630663631;6684.4652427804685;6695.230048544382;6404.391582799627;6407;6407.135036769976;6433.710483028181;6442.420182183626;6594.183770538289;6594.868102637824;6633.436157926631;6634.601923884582;6670.599764014175;6209.223847019122;6261.96869015652;6310.716017779119;6339.2392912850755;6353.872922541431;6218.782342617987;6426.907425737542;6429.51778616615;6437.806865794034;6452.645104519109;6193.504519638328;6211.689415529296;6267.310595834546;6280.780172693934;6312.116303717391;6218.657973811484;6225.501959843292;6236.501079913687;6292.402221788922;6305.369463053658;6068.423499767515;6104.156010547632;6115.635867915819;6123.632582045091;6131.172291740736;5533.6403133796175;6213.937860621336;6224.688765561795;6268.905966410416;6269.905951410641;6139.508839292756;6243.7814676486105;6248.156498872594;6266.373362663697;6274.529410294337 15:38:30 INFO - PID 1915 | |1;ext.html;789.5854676294945;813.3940214540166;933.2860361823202;943.7876477792502;958.8322043642361;37702.81148594257;38359.808200958956;38507;38587.64943226988;38726.8063659682;36827.63172368275;37183;37206;37347.43978840319;38561.42157867627;7598.582077985722;10620.840687389657;10897.182711296646;10940.726481837939;10960.616378426757;10867.83698244527;10929;10963.177761667866;10976.067034302094;10998.010179083882;9468.81062378752;11013.504392302366;11058.22592418531;11108.444577771119;11138.777224455505;10530.210234232463;11001.669949901436;11028.44857757109;11094.278871873303;11107.444627768578;10847.728806779814;10911.236213465061;10921.563137474492;10926;10946.890531094667;31563.52654710181;38895.833125006015;39051.21897562061;39089.80455097706;39104.21791564181;3222.822744749038;3779.3764028935193;3815.637514436124;3817.1793064491267;3978.5026871641044;28959.71040289591;29111.56332655012;29255.2686182845;29368.41263174746;29432.55851162234;3088.9536656950163;3240.7083362497488;3265.8367081645824;3282.96717032829;3300.669933006704;235484;337131;338828;339306.30346848356;339775;42648.57351426508;46650.76674616673;51175.23237151446;51456.97086058258;51673.44979650617;53915.460845391826;54012.919741605736;54016.72991635017;54207.728961354944;54350.45649543533;14783.408663653549;14861.702765944621;14909.105453672815;14916.92541537307;14940.477083302032;11998.400079995965;12093.516259349528;12114.15200935926;12140.878591214152;12144.271343719229;11847.512022475377;14030.29848507591;14060.015798894185;14084.43662253519;14205.21871297068;5878.823635290948;5973.790917317873;5997.610155339889;6009.609375390585;6058.787942421994;900.7207765592688;1093.797647435227;1096.9341839489657;1134.274064598641;1135.7960561804348;26312.21063368102;26523.336916576853;26536.203913882615;26677.86661066682;26700;1162.5175552145765;1186.4542310537076;1211.4185191108318;1216.916943919912;1239.3988915376035;11060.562126923449;13656.112352697042;13743;13847.238401887993;13876;445315;447060;447775;448354;450403;54480.727596361765;54914.72542637261;55010.44989550133;55027;55119.448805511434;1246.8067449545154;1260.861305256421;1416.122004357305;1455.0178629425095;1468.1851572377434;21374.57250854943;24928;27139.59290610603;28201.012964546964;29726.702732972393;48631.75684121557;49401.50598493969;49607;49689.503104968484;49939.001219976126;376781.2321876746;379084;381627;383584;383969;27836.721632783414;31236.843815780776;32173.03480895577;32798.67201327956;32864.849730259324;41212.793936030124;41744.37383439312;41862.581374185866;41892.16215675609;42658;32447.307025065908;33183.668163318056;34567.30865382628;35468;35762.82118589494;31239.06282811519;31414.743410263334;33922.66077339195;34328.79849205266;34526.309473810885;35113.64886351206;35307.11732206613;35616.57533698727;35784.95827854661;35848.64151358453;27009.45981080328;29142.97999570005;29623.815047398726;30512.08463746091;30812;21546.892265538572;22001.129903958343;23066.654000189676;23375.298741037797;23606 15:38:30 INFO - PID 1915 | |2;jquery.html;356.4403885899139;399.6642820031177;411.5082476440651;418.28682097024574;431.73232595790614;20131;20980.580388392224;20998.685019724697;21035.894820525875;21257;21470.677939830915;21796.564068718617;22059.89700514972;22127.004284807183;22145.55708885821;6094.786682466114;6573.671316434183;6928.653567321639;6987.790366288994;6993.440524758033;6647.335266473338;6730.956701711219;6808.2170550386845;6845.8973115403305;6866.965665171692;6571.474282057424;6797.558158719692;6805.489588280874;6853.143357080365;6854.417374523172;6692.799216023503;6823.249442561314;6868.587884726882;6877.89683154753;6903.068085808427;6563.868722625521;6599.142111525519;6653.135092438;6693.364130407604;6695.3639404257;26243.606345904827;26250.212493625222;26347.341316467242;26532;26777.33056673599;3155.195425166568;3350.832458377096;3407.092395894398;3427.657234276577;3512.2624248907505;15928.920355398264;16418.097004664858;16517.256723447354;17217.827821721872;17308.307667693276;1970.9310174143836;1978.9604207915904;2121.512052227981;2121.5968965896586;2123.6920646506323;89384.6592301116;116197;127695;153546;157387;21361.941231166027;21767.34697959064;22028;22075;22280.66579001316;35836.74571389989;35850.64149358473;36081.45877811835;36203.63796362003;36273.81863090667;8887.511186884654;10553.314034587727;10625.46872656364;10626.46867656614;10830.40432776205;8481.109483504266;8601;8626.309895208493;8765.298776097898;8790;8799.47203167812;10768.084712799344;10840.295380800222;10848.799604116804;10975.341479511255;3718.200586873835;4261.829526818892;4327.870163895025;4368.388425620416;4382.444232297488;1045.3936716704293;1056.8784589772122;1086.315621158665;1098.3629494892944;1113.8384934184498;21712.240071597418;22859;23135.305940821803;23397;23433.41416464602;998.2562990571926;1073.6510634043966;1076.1498416251231;1106.0598491282506;1113.5156207049959;11032.44837758109;11808.232464889754;12123.151379403356;12336.951359134395;12559.5604153856;628852.8557357184;646557;656941;658065;669597.6520117465;103731;122497;142418.28790856188;148698;150135;1109.8557187565564;1268.9746205075846;1277.0741212620962;1332.6734949937327;1340.2896464873634;19706.901465493153;21424.289054537487;21618.89190554037;21828.126874924827;21918;61772;61986.38013619986;63087.6845615769;63612;64102.35897640964;69399;80268;81956.59021704854;84022.61647886374;88939.55530222307;9852.507374631383;11994.62061862897;12393.256404615751;12764.29796361209;12767.106302558732;13791.2414817182;13873.722525549634;13963.30183490801;14318.427262909367;14332;11690.415479225834;11750.412479375826;11826.940865295619;11876.76246475083;12066.75866482683;11599.130065244972;11739;11825.053995680497;11831.76336473283;12229.93885030569;11697.590584329508;11994.880051199376;12029.699257518632;12098.153129280865;12160.209586376857;9667.178289845442;12258.509659613515;12354.467334196648;12356.3821808911;12552.43514041852;10623;11633.941830290794;11727.648170554898;11883.881161188277;11933.76132477363 15:38:30 INFO - PID 1915 | |3;mootools.html;1488.724585951599;1549.9922500387497;1555.4866893924998;1585.3579300383342;1593.378582352882;9342.439453632769;9749.31754777166;10473.423961682105;10926.180536459757;10962.958518940708;8589.613467393967;10764.13886889049;10787.083097936666;10801.5679372825;10809.729756756085;2320.907163713454;2362.090595120874;2365.5032443186865;2368.9407764805933;2372.644103384489;2323.1172154581236;2357.5520651076326;2362.208660098869;2364.9645255321184;2368;2336.5677349690277;2347.9786292962617;2352.9176478823247;2362.5274945011065;2363.1847012780563;2304.7580004099495;2318.385627808632;2323.2101085630798;2323.8721870297213;2327.150590034642;2268.8184945204343;2321.630238159494;2324.8953797079002;2327.8021368183554;2330.6387509935985;10783.46082695862;10840.512176951977;10886.183536234814;10890.945545272301;10929.890701092967;5506.587005974568;5604.579656525777;5710.2862142232225;5847.473727364558;5850.268716410449;3316.2704205074847;3448.448248280263;3579.910502237439;3668.596454390015;3679.742418030739;1138.6336396324361;1190.94640741166;1207.4807832631964;1216.2580825696318;1229.4221715793562;14999.850001499954;15110.0178488399;15114.319855606414;15149.848501514954;15173.848261517354;4677.311878378018;4798.904021919542;4842.104210721028;4930.605551555867;4972.154733695208;12662.873371266169;12756.48974041028;12793.29636869981;12802.80795788064;12809.807852882213;5796.449337312949;5891.23413956183;5916.053431450947;5935;5951.583389162717;4488.483824360175;4918.336024636628;5213.13983192769;5259.447757985433;5274.3143391359645;2985.5969444124767;3228.790128641631;3729.030452082424;3976.6421022108148;4016.718829681894;1012.9414761574172;1138.6014894786924;1140.7547377313917;1147.7876592830353;1151.176908510419;954.7947191353892;959.4339339789558;976.2043934193609;979.2704435195682;985.4875464758286;6467.741290348334;6543.1821022372205;6708.899366509506;6810.455163586901;6825.55633883796;936.3398803843274;967.5065716484644;1009.535613617744;1031.5358088860044;1044.895510448949;3861.846051646645;4000.6999475038906;4083.244599749056;4090.775007374623;4215.641670458045;12918.935405323102;13152.473901044043;13397.732045359038;13444.596662100153;13529.052966292462;13117.147385419918;13142.145760525535;13176.670583235496;13201.801972970414;13206.999999999807;9578.760530986641;9958;9981.550830212658;10016.1987041038;10027.197824174049;5641.943580564306;6636.43590294811;6682.9975503672895;6718.462522998246;6921.065656136559;9280.257579393498;9622.278329125204;12008.63974080744;12164.695882603006;12202.389880506116;11484.679261884656;12262.632121036384;12365.567205147776;12426.62720118398;12429.192102513307;7523.887141692989;8167.632456539589;9016;9059.68634548;9277.953610231905;8253.752387428387;9935.503224838585;10016.699499015042;10045.196384289093;10048.648297309559;8584.356173286904;8971.013188549385;9019.549022548978;9027.4132181408;9067.455952642862;8817.603207855791;8866.379353445196;8909.465432074096;8951.910480895369;8976.057513961201;6137.631742095488;7787.260210280015;7835.647395867086;7927.563983980936;7930.444868859125;5894.646321220741;5981.7308221131025;6001.06983417571;6045.941960157043;6054.8183554493435;5974.2830860297045;5978.790742323998;6053.848653783691;6101.328853825987;6116.877662446637 15:38:30 INFO - PID 1915 | |4;prototype.html;380.05745750538665;387.38792707522117;389.9532056153262;391.37575566970673;394.76708741842305;5996.880062398749;5997.460228579427;6102.908456373158;6117.082437634352;6197.876042479148;4704.835330763424;5118.436971933084;5902.291724993007;6014.849628759283;6044.335123136451;4740.004599034207;4948.50514948504;4977.979514199598;4985.626078044153;5016.573591244749;4972.453030166696;5001.799928002875;5003.699778013312;5024.748762561876;5028.723420211887;4245.384419259206;4885.5114488551035;4915.680480768739;4958.553730164284;5006.399232092136;4768.427788665365;4912;4936.234883593013;4939.629527785394;4951.183054795954;3932.4101384792225;4509.549045095497;4521.231390663595;4529.2526733089;4530.365748795171;4928.901421971576;5131.5638170755155;5812.505936995361;5879.500242479395;5931.762729490815;4805.519448055166;5694.288213973254;5734;5754.482096611325;5775.758211984444;5482.451754824526;5908.125796218137;6463.159789227418;6547.9672601636685;6557.475401967831;4757.548032936866;4983.252512123175;5061.493850614946;5093.770780314895;5097.5667068299235;6531.126304426085;6547.443467305285;6712.328767123297;6746.662666866686;6872.793816185523;4295.82816687329;4934.432540257844;5257.053730328577;5257.158854583248;5272.446393128743;4707.976460117678;5342.305500284938;5355.732213389315;5366.168243922199;5380.91928621071;5565.666060036411;5710.543156547466;5766.711664416763;5777.45114214149;5813.447722466359;6482.740690372427;6515.641639709862;6519.109458257052;6523.315051919575;6576.835579110465;1631.1681042668088;1723.5346456456687;1775.3675178996514;1786.3926265069938;1813.8820976636475;1250.6055747841274;1252.9498820047097;1331.8468376136868;1343.2209318595192;1345.663584103974;5198.818041368534;5816.749398879261;6088.360722124113;6091.669788934682;6100.603460775035;5575.0522411190195;5636.689982051026;6612.768553100618;6714.932850671431;6729.360710732472;5041.193409054534;5818.5345172386105;5940.554458415636;5942.456332840204;6059.515238780887;2764.986175069152;3152.432562138837;3490.511328414024;3545.6986156177013;3546.982265088658;6517.804465866032;6594.307597702268;6980.173029922889;6981.5461994970165;7007.299270073054;5670.943290567124;6046.425589568984;6833.8745940544595;6907.20567134786;6934.375906168469;5555.805546805843;5854.502367298657;6117.908231376533;6818.659067046727;7001.404880585105;5169.974150129226;5819.330776960704;6270.717817698123;6700.966495167688;6757.425618822259;4948.035133149001;6299.212598425197;6450.741970321323;6611.966940165268;6645.6677166140535;5859.882802343844;6012.969935150296;6043.7884674036195;6459.806205813833;6860.759873404607;4758.857874110258;5195.870103247449;5211.60912931524;5223.2948551945;5258.447862974333;5272.314599102092;6636.7013484392355;6661.966690166518;6705.463562914858;6711.187979245674;5750.884982300414;6124.785632502841;6296.496280297473;6376.776812811529;6562.409383155348;4642.698224615389;4848.927266091082;5324.866878328073;5524.005678977823;6305;5327.493888080626;5969.52243820502;6257.906131408124;6297.4017468340435;6356.523260755369;5433.429489903503;6239.563230573816;6282.277538083179;6386.201724784402;6436.884959288788;5997.700114994145;6246.281677607133;6271.96864015677;6287.799270255374;6301.6534090625455 15:38:30 INFO - PID 1915 | |5;yui.html;602.8114731823013;671.4561205423604;697.4176562570253;757.0574634579949;835.6156168162645;13371.59885203443;14898.702025959474;15288.159151246677;15515.68968620627;15626.984246024;14341.498047568337;14584.489542866002;14620.195889226088;14648.194349310783;14648.780268295985;929.8372784762656;958.156821996642;963.2631037256505;965.4159233663603;970.2674480767012;827.8178800663844;934.8971613122551;957.1529196660936;962.7785609309863;978.9510524473783;1019.1286450085181;1037.3827572594294;1040.599369242843;1043.6608102366724;1046.4192373232852;1012.3824467075078;1023.5240613114863;1027.650598796409;1029.5984566019258;1030.1243942648764;759.3317880265331;770.6917233106747;772.0773675457774;772.9652165652559;774.3456779021718;15913.20433978308;15968.76046859298;16557.420490282904;16664.83335166645;16907;14224.573262802132;14898.851011489854;14971.775423368657;15049.172295523742;15666.903316767832;11446.542138314457;11607.053801192902;11709.94145029278;11732.061435085257;11851.288922664582;3652.9086772830624;3668.6147954464664;3699.505511639526;3735.1035751419736;3895.357266051098;112865.43567282193;113580.43209783899;113659.43170284096;114590;116399;11335.263207891461;11443.141764367705;11835.526578936919;11883.227590206781;11900.285982841056;24299.39251518726;24914.12800551972;25215.495690086464;25224;25249.62125568118;7793.688252469951;7849.960750196326;7975.242351976669;8025;8128;4136.358864376027;4201.663866890642;4214.536400995888;4246.087091275391;4248.362745588187;3427.417339052367;3477.3566890125408;3493.7729047611824;3508.1755787389943;3517.50754894315;624.2384291164772;628.3779058731914;634.1977398590786;641.2977789320686;643.5077165968038;643.530222937249;652.8857449946336;672.5527524196452;701.9929800701927;725.6553137259759;9847.852282215772;10037.841863999129;10114.494275286206;10152.340097893613;10431.634892778717;617.7528988404674;656.0351746519206;675.6284043776002;694.1046050594676;698.4098436820879;4644.744539050317;4898.632602554751;4924.1875090610365;4933.432655244621;4946.1344264753525;98791;98869.66389873427;99679.50160249152;100566.49716751369;101878.98121018695;86148;86618.13381866101;87925.56037219772;88476;88484.6727299091;63370.09889703316;73811.89282160772;74589;75280.24719752841;75384.24615753882;8517.914820851713;8914.955425222832;9013.84459981383;9359;9486.715398538056;43772.56227437812;47239.29141062956;47977.56067317986;48370.758146209046;48478.757606213156;60379;60835.78328433318;61075.389246108745;61129;61159.388406115366;11681.415929203677;11865.940670296593;12484.250944943333;13087;14302.642433938818;14608.123512589278;14623.707525849637;14797.440938987856;14842.232528640137;14916.552503424915;13326.800097998344;13473.915779355462;13531.255780932142;13790.65523361924;14523.838092952326;12311.322877241837;13761.783801857477;13816.309184540532;13927.791083133558;14193.645158871112;12831.602654814447;12973;13038.608841734764;13269.402876870758;13488.190708557519;9859;10456.477176141314;11181.32912025281;11210.943945280222;11616.128790340927;7743.57410342414;8460.362044321;10139.246983313355;10556.935579801679;11151.72120696989 15:38:30 INFO - PID 1915 | __end_tp_report 15:38:30 INFO - PID 1915 | __start_cc_report 15:38:30 INFO - PID 1915 | _x_x_mozilla_cycle_collect,427 15:38:30 INFO - PID 1915 | __end_cc_report 15:38:30 INFO - PID 1915 | __startTimestamp1489703910707__endTimestamp 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | ------- Summary: start ------- 15:38:30 INFO - PID 1915 | Number of tests: 6 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | [#0] dojo.html Cycles:165 Average:5931.97 Median:6211.69 stddev:653.19 (10.5%) stddev-sans-first:624.93 15:38:30 INFO - PID 1915 | Values: 3426.7 3452.6 3453.9 3459.0 3470.6 5864.4 5993.3 6024.7 6065.4 6069.8 5143.0 5837.4 5983.4 6012.9 6100.7 5376.1 5429.3 5463.0 5481.9 5500.6 5395.8 5451.0 5513.0 5521.9 5553.1 5372.0 5408.6 5435.1 5466.5 5482.3 5417.2 5418.5 5430.4 5446.8 5491.2 5380.8 5387.8 5399.5 5419.3 5478.2 5777.5 5808.2 5848.2 5983.6 6006.4 5873.7 5895.4 6268.5 6358.7 6376.6 6371.9 6375.9 6423.0 6428.2 6440.3 5060.3 5956.1 6028.8 6066.8 6098.6 6322.4 6420.9 6490.9 6541.7 6556.9 6192.2 6212.2 6253.6 6287.8 6313.2 6300.2 6415.9 6419.6 6420.3 6439.5 6346.2 6359.0 6372.4 6373.0 6436.1 6237.0 6261.4 6290.7 6311.9 6321.5 5164.3 5176.2 5181.4 5185.2 5217.6 4002.5 4610.0 4613.7 4616.7 4662.6 5298.7 5922.2 6039.8 6220.5 6238.6 6221.9 6296.8 6416.4 6417.2 6455.6 6158.0 6205.4 6219.1 6227.0 6227.3 5658.8 5714.3 5723.6 5747.0 5758.7 6432.4 6473.8 6636.9 6684.5 6695.2 6404.4 6407.0 6407.1 6433.7 6442.4 6594.2 6594.9 6633.4 6634.6 6670.6 6209.2 6262.0 6310.7 6339.2 6353.9 6218.8 6426.9 6429.5 6437.8 6452.6 6193.5 6211.7 6267.3 6280.8 6312.1 6218.7 6225.5 6236.5 6292.4 6305.4 6068.4 6104.2 6115.6 6123.6 6131.2 5533.6 6213.9 6224.7 6268.9 6269.9 6139.5 6243.8 6248.2 6266.4 6274.5 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | [#1] ext.html Cycles:180 Average:52857.88 Median:3231.77 stddev:102260.32 (3164.2%) stddev-sans-first:102472.46 15:38:30 INFO - PID 1915 | Values: 789.6 813.4 933.3 943.8 958.8 37702.8 38359.8 38507.0 38587.6 38726.8 36827.6 37183.0 37206.0 37347.4 38561.4 7598.6 10620.8 10897.2 10940.7 10960.6 10867.8 10929.0 10963.2 10976.1 10998.0 9468.8 11013.5 11058.2 11108.4 11138.8 10530.2 11001.7 11028.4 11094.3 11107.4 10847.7 10911.2 10921.6 10926.0 10946.9 31563.5 38895.8 39051.2 39089.8 39104.2 3222.8 3779.4 3815.6 3817.2 3978.5 28959.7 29111.6 29255.3 29368.4 29432.6 3089.0 3240.7 3265.8 3283.0 3300.7 235484.0 337131.0 338828.0 339306.3 339775.0 42648.6 46650.8 51175.2 51457.0 51673.4 53915.5 54012.9 54016.7 54207.7 54350.5 14783.4 14861.7 14909.1 14916.9 14940.5 11998.4 12093.5 12114.2 12140.9 12144.3 11847.5 14030.3 14060.0 14084.4 14205.2 5878.8 5973.8 5997.6 6009.6 6058.8 900.7 1093.8 1096.9 1134.3 1135.8 26312.2 26523.3 26536.2 26677.9 26700.0 1162.5 1186.5 1211.4 1216.9 1239.4 11060.6 13656.1 13743.0 13847.2 13876.0 445315.0 447060.0 447775.0 448354.0 450403.0 54480.7 54914.7 55010.4 55027.0 55119.4 1246.8 1260.9 1416.1 1455.0 1468.2 21374.6 24928.0 27139.6 28201.0 29726.7 48631.8 49401.5 49607.0 49689.5 49939.0 376781.2 379084.0 381627.0 383584.0 383969.0 27836.7 31236.8 32173.0 32798.7 32864.8 41212.8 41744.4 41862.6 41892.2 42658.0 32447.3 33183.7 34567.3 35468.0 35762.8 31239.1 31414.7 33922.7 34328.8 34526.3 35113.6 35307.1 35616.6 35785.0 35848.6 27009.5 29143.0 29623.8 30512.1 30812.0 21546.9 22001.1 23066.7 23375.3 23606.0 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | [#2] jquery.html Cycles:180 Average:39442.20 Median:21781.96 stddev:108519.94 (498.2%) stddev-sans-first:108784.68 15:38:30 INFO - PID 1915 | Values: 356.4 399.7 411.5 418.3 431.7 20131.0 20980.6 20998.7 21035.9 21257.0 21470.7 21796.6 22059.9 22127.0 22145.6 6094.8 6573.7 6928.7 6987.8 6993.4 6647.3 6731.0 6808.2 6845.9 6867.0 6571.5 6797.6 6805.5 6853.1 6854.4 6692.8 6823.2 6868.6 6877.9 6903.1 6563.9 6599.1 6653.1 6693.4 6695.4 26243.6 26250.2 26347.3 26532.0 26777.3 3155.2 3350.8 3407.1 3427.7 3512.3 15928.9 16418.1 16517.3 17217.8 17308.3 1970.9 1979.0 2121.5 2121.6 2123.7 89384.7 116197.0 127695.0 153546.0 157387.0 21361.9 21767.3 22028.0 22075.0 22280.7 35836.7 35850.6 36081.5 36203.6 36273.8 8887.5 10553.3 10625.5 10626.5 10830.4 8481.1 8601.0 8626.3 8765.3 8790.0 8799.5 10768.1 10840.3 10848.8 10975.3 3718.2 4261.8 4327.9 4368.4 4382.4 1045.4 1056.9 1086.3 1098.4 1113.8 21712.2 22859.0 23135.3 23397.0 23433.4 998.3 1073.7 1076.1 1106.1 1113.5 11032.4 11808.2 12123.2 12337.0 12559.6 628852.9 646557.0 656941.0 658065.0 669597.7 103731.0 122497.0 142418.3 148698.0 150135.0 1109.9 1269.0 1277.1 1332.7 1340.3 19706.9 21424.3 21618.9 21828.1 21918.0 61772.0 61986.4 63087.7 63612.0 64102.4 69399.0 80268.0 81956.6 84022.6 88939.6 9852.5 11994.6 12393.3 12764.3 12767.1 13791.2 13873.7 13963.3 14318.4 14332.0 11690.4 11750.4 11826.9 11876.8 12066.8 11599.1 11739.0 11825.1 11831.8 12229.9 11697.6 11994.9 12029.7 12098.2 12160.2 9667.2 12258.5 12354.5 12356.4 12552.4 10623.0 11633.9 11727.6 11883.9 11933.8 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | [#3] mootools.html Cycles:180 Average:6612.67 Median:3382.36 stddev:4119.23 (121.8%) stddev-sans-first:4112.79 15:38:30 INFO - PID 1915 | Values: 1488.7 1550.0 1555.5 1585.4 1593.4 9342.4 9749.3 10473.4 10926.2 10963.0 8589.6 10764.1 10787.1 10801.6 10809.7 2320.9 2362.1 2365.5 2368.9 2372.6 2323.1 2357.6 2362.2 2365.0 2368.0 2336.6 2348.0 2352.9 2362.5 2363.2 2304.8 2318.4 2323.2 2323.9 2327.2 2268.8 2321.6 2324.9 2327.8 2330.6 10783.5 10840.5 10886.2 10890.9 10929.9 5506.6 5604.6 5710.3 5847.5 5850.3 3316.3 3448.4 3579.9 3668.6 3679.7 1138.6 1190.9 1207.5 1216.3 1229.4 14999.9 15110.0 15114.3 15149.8 15173.8 4677.3 4798.9 4842.1 4930.6 4972.2 12662.9 12756.5 12793.3 12802.8 12809.8 5796.4 5891.2 5916.1 5935.0 5951.6 4488.5 4918.3 5213.1 5259.4 5274.3 2985.6 3228.8 3729.0 3976.6 4016.7 1012.9 1138.6 1140.8 1147.8 1151.2 954.8 959.4 976.2 979.3 985.5 6467.7 6543.2 6708.9 6810.5 6825.6 936.3 967.5 1009.5 1031.5 1044.9 3861.8 4000.7 4083.2 4090.8 4215.6 12918.9 13152.5 13397.7 13444.6 13529.1 13117.1 13142.1 13176.7 13201.8 13207.0 9578.8 9958.0 9981.6 10016.2 10027.2 5641.9 6636.4 6683.0 6718.5 6921.1 9280.3 9622.3 12008.6 12164.7 12202.4 11484.7 12262.6 12365.6 12426.6 12429.2 7523.9 8167.6 9016.0 9059.7 9278.0 8253.8 9935.5 10016.7 10045.2 10048.6 8584.4 8971.0 9019.5 9027.4 9067.5 8817.6 8866.4 8909.5 8951.9 8976.1 6137.6 7787.3 7835.6 7927.6 7930.4 5894.6 5981.7 6001.1 6045.9 6054.8 5974.3 5978.8 6053.8 6101.3 6116.9 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | [#4] prototype.html Cycles:180 Average:5316.43 Median:5752.68 stddev:1500.39 (26.1%) stddev-sans-first:1458.13 15:38:30 INFO - PID 1915 | Values: 380.1 387.4 390.0 391.4 394.8 5996.9 5997.5 6102.9 6117.1 6197.9 4704.8 5118.4 5902.3 6014.8 6044.3 4740.0 4948.5 4978.0 4985.6 5016.6 4972.5 5001.8 5003.7 5024.7 5028.7 4245.4 4885.5 4915.7 4958.6 5006.4 4768.4 4912.0 4936.2 4939.6 4951.2 3932.4 4509.5 4521.2 4529.3 4530.4 4928.9 5131.6 5812.5 5879.5 5931.8 4805.5 5694.3 5734.0 5754.5 5775.8 5482.5 5908.1 6463.2 6548.0 6557.5 4757.5 4983.3 5061.5 5093.8 5097.6 6531.1 6547.4 6712.3 6746.7 6872.8 4295.8 4934.4 5257.1 5257.2 5272.4 4708.0 5342.3 5355.7 5366.2 5380.9 5565.7 5710.5 5766.7 5777.5 5813.4 6482.7 6515.6 6519.1 6523.3 6576.8 1631.2 1723.5 1775.4 1786.4 1813.9 1250.6 1252.9 1331.8 1343.2 1345.7 5198.8 5816.7 6088.4 6091.7 6100.6 5575.1 5636.7 6612.8 6714.9 6729.4 5041.2 5818.5 5940.6 5942.5 6059.5 2765.0 3152.4 3490.5 3545.7 3547.0 6517.8 6594.3 6980.2 6981.5 7007.3 5670.9 6046.4 6833.9 6907.2 6934.4 5555.8 5854.5 6117.9 6818.7 7001.4 5170.0 5819.3 6270.7 6701.0 6757.4 4948.0 6299.2 6450.7 6612.0 6645.7 5859.9 6013.0 6043.8 6459.8 6860.8 4758.9 5195.9 5211.6 5223.3 5258.4 5272.3 6636.7 6662.0 6705.5 6711.2 5750.9 6124.8 6296.5 6376.8 6562.4 4642.7 4848.9 5324.9 5524.0 6305.0 5327.5 5969.5 6257.9 6297.4 6356.5 5433.4 6239.6 6282.3 6386.2 6436.9 5997.7 6246.3 6272.0 6287.8 6301.7 15:38:30 INFO - PID 1915 | 15:38:30 INFO - PID 1915 | [#5] yui.html Cycles:180 Average:20296.91 Median:3500.97 stddev:29127.19 (832.0%) stddev-sans-first:29171.36 15:38:30 INFO - PID 1915 | Values: 602.8 671.5 697.4 757.1 835.6 13371.6 14898.7 15288.2 15515.7 15627.0 14341.5 14584.5 14620.2 14648.2 14648.8 929.8 958.2 963.3 965.4 970.3 827.8 934.9 957.2 962.8 979.0 1019.1 1037.4 1040.6 1043.7 1046.4 1012.4 1023.5 1027.7 1029.6 1030.1 759.3 770.7 772.1 773.0 774.3 15913.2 15968.8 16557.4 16664.8 16907.0 14224.6 14898.9 14971.8 15049.2 15666.9 11446.5 11607.1 11709.9 11732.1 11851.3 3652.9 3668.6 3699.5 3735.1 3895.4 112865.4 113580.4 113659.4 114590.0 116399.0 11335.3 11443.1 11835.5 11883.2 11900.3 24299.4 24914.1 25215.5 25224.0 25249.6 7793.7 7850.0 7975.2 8025.0 8128.0 4136.4 4201.7 4214.5 4246.1 4248.4 3427.4 3477.4 3493.8 3508.2 3517.5 624.2 628.4 634.2 641.3 643.5 643.5 652.9 672.6 702.0 725.7 9847.9 10037.8 10114.5 10152.3 10431.6 617.8 656.0 675.6 694.1 698.4 4644.7 4898.6 4924.2 4933.4 4946.1 98791.0 98869.7 99679.5 100566.5 101879.0 86148.0 86618.1 87925.6 88476.0 88484.7 63370.1 73811.9 74589.0 75280.2 75384.2 8517.9 8915.0 9013.8 9359.0 9486.7 43772.6 47239.3 47977.6 48370.8 48478.8 60379.0 60835.8 61075.4 61129.0 61159.4 11681.4 11865.9 12484.3 13087.0 14302.6 14608.1 14623.7 14797.4 14842.2 14916.6 13326.8 13473.9 13531.3 13790.7 14523.8 12311.3 13761.8 13816.3 13927.8 14193.6 12831.6 12973.0 13038.6 13269.4 13488.2 9859.0 10456.5 11181.3 11210.9 11616.1 7743.6 8460.4 10139.2 10556.9 11151.7 15:38:30 INFO - PID 1915 | -------- Summary: end -------- 15:38:30 INFO - PID 1915 | 15:38:31 INFO - TEST-INFO | 1915: exit 0 15:38:31 INFO - TEST-OK | dromaeo_css | took 1117393ms 15:38:31 INFO - TEST-START | kraken 15:38:31 INFO - operating with platform_type : mac_ 15:38:31 INFO - Initialising browser for kraken test... 15:38:31 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpC73RFz/profile http://localhost:49373/getInfo.html) 15:38:34 INFO - PID 1921 | 2017-03-16 15:38:34.464 plugin-container[1922:17383] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3b, name = 'com.apple.tsm.portname' 15:38:34 INFO - PID 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:38:34 INFO - PID 1921 | 2017-03-16 15:38:34.466 plugin-container[1922:17383] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 15:38:34 INFO - PID 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:38:34 INFO - PID 1921 | 2017-03-16 15:38:34.466 plugin-container[1922:17383] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:38:34 INFO - PID 1921 | __metrics Screen width/height:1600/1200 15:38:34 INFO - PID 1921 | colorDepth:24 15:38:34 INFO - PID 1921 | Browser inner width/height: 1024/689 15:38:34 INFO - PID 1921 | __metrics 15:38:34 ERROR - PID 1921 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 15:38:35 INFO - TEST-INFO | 1921: exit 0 15:38:35 INFO - Browser initialized. 15:38:35 INFO - Running cycle 1/1 for kraken test... 15:38:35 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpC73RFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:37 INFO - PID 1923 | 2017-03-16 15:38:37.852 plugin-container[1924:17507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 15:38:37 INFO - PID 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:38:37 INFO - PID 1923 | 2017-03-16 15:38:37.852 plugin-container[1924:17507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 15:38:37 INFO - PID 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:38:37 INFO - PID 1923 | 2017-03-16 15:38:37.852 plugin-container[1924:17507] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:38:47 INFO - PID 1923 | RSS: Main: 227475456 15:38:47 INFO - PID 1923 | 15:38:50 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:51 INFO - PID 1923 | RSS: Main: 242061312 15:38:51 INFO - PID 1923 | 15:38:54 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-dft) 15:38:54 INFO - PID 1923 | RSS: Main: 250363904 15:38:54 INFO - PID 1923 | 15:38:58 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-fft) 15:38:58 INFO - PID 1923 | RSS: Main: 253190144 15:38:58 INFO - PID 1923 | 15:39:00 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49373/tests/kraken/driver.html?testName=audio-oscillator) 15:39:01 INFO - PID 1923 | RSS: Main: 255307776 15:39:01 INFO - PID 1923 | 15:39:03 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:03 INFO - PID 1923 | RSS: Main: 255995904 15:39:03 INFO - PID 1923 | 15:39:06 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49373/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:07 INFO - PID 1923 | RSS: Main: 261275648 15:39:07 INFO - PID 1923 | 15:39:10 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49373/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:11 INFO - PID 1923 | RSS: Main: 261668864 15:39:11 INFO - PID 1923 | 15:39:14 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49373/tests/kraken/driver.html?testName=json-parse-financial) 15:39:15 INFO - PID 1923 | RSS: Main: 261468160 15:39:15 INFO - PID 1923 | 15:39:16 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:17 INFO - PID 1923 | RSS: Main: 261337088 15:39:17 INFO - PID 1923 | 15:39:19 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:19 INFO - PID 1923 | RSS: Main: 261349376 15:39:19 INFO - PID 1923 | 15:39:22 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:22 INFO - PID 1923 | RSS: Main: 261439488 15:39:22 INFO - PID 1923 | 15:39:25 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:26 INFO - PID 1923 | RSS: Main: 261853184 15:39:26 INFO - PID 1923 | 15:39:29 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:30 INFO - PID 1923 | RSS: Main: 261574656 15:39:30 INFO - PID 1923 | 15:39:31 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:49373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49373/tests/kraken/driver.html?testName=ai-astar) 15:39:32 INFO - PID 1923 | RSS: Main: 263225344 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | __start_tp_report 15:39:32 INFO - PID 1923 | _x_x_mozilla_page_load 15:39:32 INFO - PID 1923 | _x_x_mozilla_page_load_details 15:39:32 INFO - PID 1923 | |i|pagename|runs| 15:39:32 INFO - PID 1923 | |0;ai-astar;118;184;157;129;180;121;123;118;121;113 15:39:32 INFO - PID 1923 | |1;audio-beat-detection;147;116;114;157;121;110;115;118;137;117 15:39:32 INFO - PID 1923 | |2;audio-dft;199;217;264;248;201;196;202;198;196;192 15:39:32 INFO - PID 1923 | |3;audio-fft;82;60;62;86;59;62;62;73;76;61 15:39:32 INFO - PID 1923 | |4;audio-oscillator;87;70;86;70;71;70;85;70;73;84 15:39:32 INFO - PID 1923 | |5;imaging-gaussian-blur;92;88;88;88;114;88;98;115;88;89 15:39:32 INFO - PID 1923 | |6;imaging-darkroom;125;100;142;119;155;147;96;97;96;94 15:39:32 INFO - PID 1923 | |7;imaging-desaturate;93;92;90;79;141;146;90;90;123;85 15:39:32 INFO - PID 1923 | |8;json-parse-financial;68;65;66;68;69;69;68;68;68;66 15:39:32 INFO - PID 1923 | |9;json-stringify-tinderbox;58;57;69;87;95;88;58;59;60;59 15:39:32 INFO - PID 1923 | |10;stanford-crypto-aes;74;80;111;106;84;84;86;75;86;100 15:39:32 INFO - PID 1923 | |11;stanford-crypto-ccm;155;148;148;155;129;139;142;135;201;158 15:39:32 INFO - PID 1923 | |12;stanford-crypto-pbkdf2;187;190;187;188;190;184;189;190;183;185 15:39:32 INFO - PID 1923 | |13;stanford-crypto-sha256-iterative;67;69;68;68;68;69;69;68;67;71 15:39:32 INFO - PID 1923 | __end_tp_report 15:39:32 INFO - PID 1923 | __start_cc_report 15:39:32 INFO - PID 1923 | _x_x_mozilla_cycle_collect,985 15:39:32 INFO - PID 1923 | __end_cc_report 15:39:32 INFO - PID 1923 | __startTimestamp1489703972236__endTimestamp 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | ------- Summary: start ------- 15:39:32 INFO - PID 1923 | Number of tests: 14 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#0] ai-astar Cycles:10 Average:136.40 Median:126.00 stddev:26.92 (21.4%) stddev-sans-first:27.72 15:39:32 INFO - PID 1923 | Values: 118.0 184.0 157.0 129.0 180.0 121.0 123.0 118.0 121.0 113.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:119.50 stddev:16.01 (13.4%) stddev-sans-first:14.91 15:39:32 INFO - PID 1923 | Values: 147.0 116.0 114.0 157.0 121.0 110.0 115.0 118.0 137.0 117.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#2] audio-dft Cycles:10 Average:211.30 Median:201.50 stddev:24.76 (12.3%) stddev-sans-first:25.86 15:39:32 INFO - PID 1923 | Values: 199.0 217.0 264.0 248.0 201.0 196.0 202.0 198.0 196.0 192.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#3] audio-fft Cycles:10 Average:68.30 Median:67.50 stddev:10.06 (14.9%) stddev-sans-first:9.36 15:39:32 INFO - PID 1923 | Values: 82.0 60.0 62.0 86.0 59.0 62.0 62.0 73.0 76.0 61.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:78.50 stddev:7.75 (9.9%) stddev-sans-first:7.25 15:39:32 INFO - PID 1923 | Values: 87.0 70.0 86.0 70.0 71.0 70.0 85.0 70.0 73.0 84.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:88.00 stddev:10.85 (12.3%) stddev-sans-first:11.46 15:39:32 INFO - PID 1923 | Values: 92.0 88.0 88.0 88.0 114.0 88.0 98.0 115.0 88.0 89.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#6] imaging-darkroom Cycles:10 Average:117.10 Median:124.50 stddev:23.89 (19.2%) stddev-sans-first:25.17 15:39:32 INFO - PID 1923 | Values: 125.0 100.0 142.0 119.0 155.0 147.0 96.0 97.0 96.0 94.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:90.00 stddev:24.31 (27.0%) stddev-sans-first:25.52 15:39:32 INFO - PID 1923 | Values: 93.0 92.0 90.0 79.0 141.0 146.0 90.0 90.0 123.0 85.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 15:39:32 INFO - PID 1923 | Values: 68.0 65.0 66.0 68.0 69.0 69.0 68.0 68.0 68.0 66.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:64.50 stddev:15.01 (23.3%) stddev-sans-first:15.38 15:39:32 INFO - PID 1923 | Values: 58.0 57.0 69.0 87.0 95.0 88.0 58.0 59.0 60.0 59.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:82.00 stddev:12.75 (15.5%) stddev-sans-first:12.38 15:39:32 INFO - PID 1923 | Values: 74.0 80.0 111.0 106.0 84.0 84.0 86.0 75.0 86.0 100.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:151.50 stddev:19.90 (13.1%) stddev-sans-first:21.05 15:39:32 INFO - PID 1923 | Values: 155.0 148.0 148.0 155.0 129.0 139.0 142.0 135.0 201.0 158.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.30 Median:188.50 stddev:2.58 (1.4%) stddev-sans-first:2.74 15:39:32 INFO - PID 1923 | Values: 187.0 190.0 187.0 188.0 190.0 184.0 189.0 190.0 183.0 185.0 15:39:32 INFO - PID 1923 | 15:39:32 INFO - PID 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.13 15:39:32 INFO - PID 1923 | Values: 67.0 69.0 68.0 68.0 68.0 69.0 69.0 68.0 67.0 71.0 15:39:32 INFO - PID 1923 | -------- Summary: end -------- 15:39:32 INFO - PID 1923 | 15:39:33 INFO - TEST-INFO | 1923: exit 0 15:39:33 INFO - TEST-OK | kraken | took 61730ms 15:39:33 INFO - SUITE-END | took 1179s 15:39:33 INFO - Completed test suite (00:19:39) 15:39:33 INFO - javascript benchmark 15:39:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7922.799741476002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3426.7087297579706, 3452.6374730653297, 3453.877489815807, 3458.982705086474, 3470.6355832637573, 5864.354920958702, 5993.280806303244, 6024.728887200075, 6065.423784740454, 6069.78755743549, 5143.0, 5837.416258374171, 5983.401659834014, 6012.909806352908, 6100.725467353968, 5376.086065368897, 5429.321334833146, 5463.043967305725, 5481.945180548183, 5500.614956953015, 5395.81114660987, 5450.972745136269, 5512.972435137819, 5521.917171242435, 5553.139263414178, 5372.0330340538685, 5408.594355423359, 5435.076037073707, 5466.508014278734, 5482.342118945732, 5417.241586177938, 5418.45815418455, 5430.402655707869, 5446.809361672362, 5491.176323551459, 5380.838574842722, 5387.78448862045, 5399.487048730364, 5419.295491586108, 5478.178273259004, 5777.480026797609, 5808.1578171165365, 5848.1520179574145, 5983.551233657493, 6006.399360064002, 5873.706314684291, 5895.380984996599, 6268.498520118425, 6358.713857876407, 6376.649284289362, 6371.872562548723, 6375.93624063758, 6423.036544518313, 6428.228612566475, 6440.323766004596, 5060.342155519759, 5956.106584012433, 6028.849278768066, 6066.848328791815, 6098.57309988301, 6322.399372059647, 6420.871582568322, 6490.870182596416, 6541.705623246965, 6556.934430655632, 6192.195014648067, 6212.192414986113, 6253.593516421418, 6287.779927702509, 6313.210848643919, 6300.180976473029, 6415.903761443582, 6419.646919419383, 6420.261669907927, 6439.452646525004, 6346.238451385863, 6359.046143078483, 6372.426481616677, 6372.968135159294, 6436.098946147543, 6237.0, 6261.436470717657, 6290.654014029181, 6311.936880631227, 6321.525885558602, 5164.2770012198325, 5176.171812509981, 5181.4300426953005, 5185.22221666753, 5217.608679349064, 4002.4996875390575, 4610.0, 4613.723176609415, 4616.722996620214, 4662.557057079572, 5298.655587386807, 5922.170896074553, 6039.818805435844, 6220.471259942956, 6238.625682459067, 6221.875562488815, 6296.811095667137, 6416.358364163546, 6417.197850268716, 6455.580387274906, 6158.0, 6205.410486003822, 6219.129321894939, 6227.0, 6227.314995350508, 5658.773649054074, 5714.342850572154, 5723.570732195102, 5746.9712651436475, 5758.683272419973, 6432.421082102446, 6473.805785826433, 6636.933630663631, 6684.4652427804685, 6695.230048544382, 6404.391582799627, 6407.0, 6407.135036769976, 6433.710483028181, 6442.420182183626, 6594.183770538289, 6594.868102637824, 6633.436157926631, 6634.601923884582, 6670.599764014175, 6209.223847019122, 6261.96869015652, 6310.716017779119, 6339.2392912850755, 6353.872922541431, 6218.782342617987, 6426.907425737542, 6429.51778616615, 6437.806865794034, 6452.645104519109, 6193.504519638328, 6211.689415529296, 6267.310595834546, 6280.780172693934, 6312.116303717391, 6218.657973811484, 6225.501959843292, 6236.501079913687, 6292.402221788922, 6305.369463053658, 6068.423499767515, 6104.156010547632, 6115.635867915819, 6123.632582045091, 6131.172291740736, 5533.6403133796175, 6213.937860621336, 6224.688765561795, 6268.905966410416, 6269.905951410641, 6139.508839292756, 6243.7814676486105, 6248.156498872594, 6266.373362663697, 6274.529410294337], "value": 5890.707368543778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.5854676294945, 813.3940214540166, 933.2860361823202, 943.7876477792502, 958.8322043642361, 37702.81148594257, 38359.808200958956, 38507.0, 38587.64943226988, 38726.8063659682, 36827.63172368275, 37183.0, 37206.0, 37347.43978840319, 38561.42157867627, 7598.582077985722, 10620.840687389657, 10897.182711296646, 10940.726481837939, 10960.616378426757, 10867.83698244527, 10929.0, 10963.177761667866, 10976.067034302094, 10998.010179083882, 9468.81062378752, 11013.504392302366, 11058.22592418531, 11108.444577771119, 11138.777224455505, 10530.210234232463, 11001.669949901436, 11028.44857757109, 11094.278871873303, 11107.444627768578, 10847.728806779814, 10911.236213465061, 10921.563137474492, 10926.0, 10946.890531094667, 31563.52654710181, 38895.833125006015, 39051.21897562061, 39089.80455097706, 39104.21791564181, 3222.822744749038, 3779.3764028935193, 3815.637514436124, 3817.1793064491267, 3978.5026871641044, 28959.71040289591, 29111.56332655012, 29255.2686182845, 29368.41263174746, 29432.55851162234, 3088.9536656950163, 3240.7083362497488, 3265.8367081645824, 3282.96717032829, 3300.669933006704, 235484.0, 337131.0, 338828.0, 339306.30346848356, 339775.0, 42648.57351426508, 46650.76674616673, 51175.23237151446, 51456.97086058258, 51673.44979650617, 53915.460845391826, 54012.919741605736, 54016.72991635017, 54207.728961354944, 54350.45649543533, 14783.408663653549, 14861.702765944621, 14909.105453672815, 14916.92541537307, 14940.477083302032, 11998.400079995965, 12093.516259349528, 12114.15200935926, 12140.878591214152, 12144.271343719229, 11847.512022475377, 14030.29848507591, 14060.015798894185, 14084.43662253519, 14205.21871297068, 5878.823635290948, 5973.790917317873, 5997.610155339889, 6009.609375390585, 6058.787942421994, 900.7207765592688, 1093.797647435227, 1096.9341839489657, 1134.274064598641, 1135.7960561804348, 26312.21063368102, 26523.336916576853, 26536.203913882615, 26677.86661066682, 26700.0, 1162.5175552145765, 1186.4542310537076, 1211.4185191108318, 1216.916943919912, 1239.3988915376035, 11060.562126923449, 13656.112352697042, 13743.0, 13847.238401887993, 13876.0, 445315.0, 447060.0, 447775.0, 448354.0, 450403.0, 54480.727596361765, 54914.72542637261, 55010.44989550133, 55027.0, 55119.448805511434, 1246.8067449545154, 1260.861305256421, 1416.122004357305, 1455.0178629425095, 1468.1851572377434, 21374.57250854943, 24928.0, 27139.59290610603, 28201.012964546964, 29726.702732972393, 48631.75684121557, 49401.50598493969, 49607.0, 49689.503104968484, 49939.001219976126, 376781.2321876746, 379084.0, 381627.0, 383584.0, 383969.0, 27836.721632783414, 31236.843815780776, 32173.03480895577, 32798.67201327956, 32864.849730259324, 41212.793936030124, 41744.37383439312, 41862.581374185866, 41892.16215675609, 42658.0, 32447.307025065908, 33183.668163318056, 34567.30865382628, 35468.0, 35762.82118589494, 31239.06282811519, 31414.743410263334, 33922.66077339195, 34328.79849205266, 34526.309473810885, 35113.64886351206, 35307.11732206613, 35616.57533698727, 35784.95827854661, 35848.64151358453, 27009.45981080328, 29142.97999570005, 29623.815047398726, 30512.08463746091, 30812.0, 21546.892265538572, 22001.129903958343, 23066.654000189676, 23375.298741037797, 23606.0], "value": 18841.00540800715, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.4403885899139, 399.6642820031177, 411.5082476440651, 418.28682097024574, 431.73232595790614, 20131.0, 20980.580388392224, 20998.685019724697, 21035.894820525875, 21257.0, 21470.677939830915, 21796.564068718617, 22059.89700514972, 22127.004284807183, 22145.55708885821, 6094.786682466114, 6573.671316434183, 6928.653567321639, 6987.790366288994, 6993.440524758033, 6647.335266473338, 6730.956701711219, 6808.2170550386845, 6845.8973115403305, 6866.965665171692, 6571.474282057424, 6797.558158719692, 6805.489588280874, 6853.143357080365, 6854.417374523172, 6692.799216023503, 6823.249442561314, 6868.587884726882, 6877.89683154753, 6903.068085808427, 6563.868722625521, 6599.142111525519, 6653.135092438, 6693.364130407604, 6695.3639404257, 26243.606345904827, 26250.212493625222, 26347.341316467242, 26532.0, 26777.33056673599, 3155.195425166568, 3350.832458377096, 3407.092395894398, 3427.657234276577, 3512.2624248907505, 15928.920355398264, 16418.097004664858, 16517.256723447354, 17217.827821721872, 17308.307667693276, 1970.9310174143836, 1978.9604207915904, 2121.512052227981, 2121.5968965896586, 2123.6920646506323, 89384.6592301116, 116197.0, 127695.0, 153546.0, 157387.0, 21361.941231166027, 21767.34697959064, 22028.0, 22075.0, 22280.66579001316, 35836.74571389989, 35850.64149358473, 36081.45877811835, 36203.63796362003, 36273.81863090667, 8887.511186884654, 10553.314034587727, 10625.46872656364, 10626.46867656614, 10830.40432776205, 8481.109483504266, 8601.0, 8626.309895208493, 8765.298776097898, 8790.0, 8799.47203167812, 10768.084712799344, 10840.295380800222, 10848.799604116804, 10975.341479511255, 3718.200586873835, 4261.829526818892, 4327.870163895025, 4368.388425620416, 4382.444232297488, 1045.3936716704293, 1056.8784589772122, 1086.315621158665, 1098.3629494892944, 1113.8384934184498, 21712.240071597418, 22859.0, 23135.305940821803, 23397.0, 23433.41416464602, 998.2562990571926, 1073.6510634043966, 1076.1498416251231, 1106.0598491282506, 1113.5156207049959, 11032.44837758109, 11808.232464889754, 12123.151379403356, 12336.951359134395, 12559.5604153856, 628852.8557357184, 646557.0, 656941.0, 658065.0, 669597.6520117465, 103731.0, 122497.0, 142418.28790856188, 148698.0, 150135.0, 1109.8557187565564, 1268.9746205075846, 1277.0741212620962, 1332.6734949937327, 1340.2896464873634, 19706.901465493153, 21424.289054537487, 21618.89190554037, 21828.126874924827, 21918.0, 61772.0, 61986.38013619986, 63087.6845615769, 63612.0, 64102.35897640964, 69399.0, 80268.0, 81956.59021704854, 84022.61647886374, 88939.55530222307, 9852.507374631383, 11994.62061862897, 12393.256404615751, 12764.29796361209, 12767.106302558732, 13791.2414817182, 13873.722525549634, 13963.30183490801, 14318.427262909367, 14332.0, 11690.415479225834, 11750.412479375826, 11826.940865295619, 11876.76246475083, 12066.75866482683, 11599.130065244972, 11739.0, 11825.053995680497, 11831.76336473283, 12229.93885030569, 11697.590584329508, 11994.880051199376, 12029.699257518632, 12098.153129280865, 12160.209586376857, 9667.178289845442, 12258.509659613515, 12354.467334196648, 12356.3821808911, 12552.43514041852, 10623.0, 11633.941830290794, 11727.648170554898, 11883.881161188277, 11933.76132477363], "value": 11862.057815089582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.724585951599, 1549.9922500387497, 1555.4866893924998, 1585.3579300383342, 1593.378582352882, 9342.439453632769, 9749.31754777166, 10473.423961682105, 10926.180536459757, 10962.958518940708, 8589.613467393967, 10764.13886889049, 10787.083097936666, 10801.5679372825, 10809.729756756085, 2320.907163713454, 2362.090595120874, 2365.5032443186865, 2368.9407764805933, 2372.644103384489, 2323.1172154581236, 2357.5520651076326, 2362.208660098869, 2364.9645255321184, 2368.0, 2336.5677349690277, 2347.9786292962617, 2352.9176478823247, 2362.5274945011065, 2363.1847012780563, 2304.7580004099495, 2318.385627808632, 2323.2101085630798, 2323.8721870297213, 2327.150590034642, 2268.8184945204343, 2321.630238159494, 2324.8953797079002, 2327.8021368183554, 2330.6387509935985, 10783.46082695862, 10840.512176951977, 10886.183536234814, 10890.945545272301, 10929.890701092967, 5506.587005974568, 5604.579656525777, 5710.2862142232225, 5847.473727364558, 5850.268716410449, 3316.2704205074847, 3448.448248280263, 3579.910502237439, 3668.596454390015, 3679.742418030739, 1138.6336396324361, 1190.94640741166, 1207.4807832631964, 1216.2580825696318, 1229.4221715793562, 14999.850001499954, 15110.0178488399, 15114.319855606414, 15149.848501514954, 15173.848261517354, 4677.311878378018, 4798.904021919542, 4842.104210721028, 4930.605551555867, 4972.154733695208, 12662.873371266169, 12756.48974041028, 12793.29636869981, 12802.80795788064, 12809.807852882213, 5796.449337312949, 5891.23413956183, 5916.053431450947, 5935.0, 5951.583389162717, 4488.483824360175, 4918.336024636628, 5213.13983192769, 5259.447757985433, 5274.3143391359645, 2985.5969444124767, 3228.790128641631, 3729.030452082424, 3976.6421022108148, 4016.718829681894, 1012.9414761574172, 1138.6014894786924, 1140.7547377313917, 1147.7876592830353, 1151.176908510419, 954.7947191353892, 959.4339339789558, 976.2043934193609, 979.2704435195682, 985.4875464758286, 6467.741290348334, 6543.1821022372205, 6708.899366509506, 6810.455163586901, 6825.55633883796, 936.3398803843274, 967.5065716484644, 1009.535613617744, 1031.5358088860044, 1044.895510448949, 3861.846051646645, 4000.6999475038906, 4083.244599749056, 4090.775007374623, 4215.641670458045, 12918.935405323102, 13152.473901044043, 13397.732045359038, 13444.596662100153, 13529.052966292462, 13117.147385419918, 13142.145760525535, 13176.670583235496, 13201.801972970414, 13206.999999999807, 9578.760530986641, 9958.0, 9981.550830212658, 10016.1987041038, 10027.197824174049, 5641.943580564306, 6636.43590294811, 6682.9975503672895, 6718.462522998246, 6921.065656136559, 9280.257579393498, 9622.278329125204, 12008.63974080744, 12164.695882603006, 12202.389880506116, 11484.679261884656, 12262.632121036384, 12365.567205147776, 12426.62720118398, 12429.192102513307, 7523.887141692989, 8167.632456539589, 9016.0, 9059.68634548, 9277.953610231905, 8253.752387428387, 9935.503224838585, 10016.699499015042, 10045.196384289093, 10048.648297309559, 8584.356173286904, 8971.013188549385, 9019.549022548978, 9027.4132181408, 9067.455952642862, 8817.603207855791, 8866.379353445196, 8909.465432074096, 8951.910480895369, 8976.057513961201, 6137.631742095488, 7787.260210280015, 7835.647395867086, 7927.563983980936, 7930.444868859125, 5894.646321220741, 5981.7308221131025, 6001.06983417571, 6045.941960157043, 6054.8183554493435, 5974.2830860297045, 5978.790742323998, 6053.848653783691, 6101.328853825987, 6116.877662446637], "value": 5072.831793219607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.05745750538665, 387.38792707522117, 389.9532056153262, 391.37575566970673, 394.76708741842305, 5996.880062398749, 5997.460228579427, 6102.908456373158, 6117.082437634352, 6197.876042479148, 4704.835330763424, 5118.436971933084, 5902.291724993007, 6014.849628759283, 6044.335123136451, 4740.004599034207, 4948.50514948504, 4977.979514199598, 4985.626078044153, 5016.573591244749, 4972.453030166696, 5001.799928002875, 5003.699778013312, 5024.748762561876, 5028.723420211887, 4245.384419259206, 4885.5114488551035, 4915.680480768739, 4958.553730164284, 5006.399232092136, 4768.427788665365, 4912.0, 4936.234883593013, 4939.629527785394, 4951.183054795954, 3932.4101384792225, 4509.549045095497, 4521.231390663595, 4529.2526733089, 4530.365748795171, 4928.901421971576, 5131.5638170755155, 5812.505936995361, 5879.500242479395, 5931.762729490815, 4805.519448055166, 5694.288213973254, 5734.0, 5754.482096611325, 5775.758211984444, 5482.451754824526, 5908.125796218137, 6463.159789227418, 6547.9672601636685, 6557.475401967831, 4757.548032936866, 4983.252512123175, 5061.493850614946, 5093.770780314895, 5097.5667068299235, 6531.126304426085, 6547.443467305285, 6712.328767123297, 6746.662666866686, 6872.793816185523, 4295.82816687329, 4934.432540257844, 5257.053730328577, 5257.158854583248, 5272.446393128743, 4707.976460117678, 5342.305500284938, 5355.732213389315, 5366.168243922199, 5380.91928621071, 5565.666060036411, 5710.543156547466, 5766.711664416763, 5777.45114214149, 5813.447722466359, 6482.740690372427, 6515.641639709862, 6519.109458257052, 6523.315051919575, 6576.835579110465, 1631.1681042668088, 1723.5346456456687, 1775.3675178996514, 1786.3926265069938, 1813.8820976636475, 1250.6055747841274, 1252.9498820047097, 1331.8468376136868, 1343.2209318595192, 1345.663584103974, 5198.818041368534, 5816.749398879261, 6088.360722124113, 6091.669788934682, 6100.603460775035, 5575.0522411190195, 5636.689982051026, 6612.768553100618, 6714.932850671431, 6729.360710732472, 5041.193409054534, 5818.5345172386105, 5940.554458415636, 5942.456332840204, 6059.515238780887, 2764.986175069152, 3152.432562138837, 3490.511328414024, 3545.6986156177013, 3546.982265088658, 6517.804465866032, 6594.307597702268, 6980.173029922889, 6981.5461994970165, 7007.299270073054, 5670.943290567124, 6046.425589568984, 6833.8745940544595, 6907.20567134786, 6934.375906168469, 5555.805546805843, 5854.502367298657, 6117.908231376533, 6818.659067046727, 7001.404880585105, 5169.974150129226, 5819.330776960704, 6270.717817698123, 6700.966495167688, 6757.425618822259, 4948.035133149001, 6299.212598425197, 6450.741970321323, 6611.966940165268, 6645.6677166140535, 5859.882802343844, 6012.969935150296, 6043.7884674036195, 6459.806205813833, 6860.759873404607, 4758.857874110258, 5195.870103247449, 5211.60912931524, 5223.2948551945, 5258.447862974333, 5272.314599102092, 6636.7013484392355, 6661.966690166518, 6705.463562914858, 6711.187979245674, 5750.884982300414, 6124.785632502841, 6296.496280297473, 6376.776812811529, 6562.409383155348, 4642.698224615389, 4848.927266091082, 5324.866878328073, 5524.005678977823, 6305.0, 5327.493888080626, 5969.52243820502, 6257.906131408124, 6297.4017468340435, 6356.523260755369, 5433.429489903503, 6239.563230573816, 6282.277538083179, 6386.201724784402, 6436.884959288788, 5997.700114994145, 6246.281677607133, 6271.96864015677, 6287.799270255374, 6301.6534090625455], "value": 4866.967943196897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.8114731823013, 671.4561205423604, 697.4176562570253, 757.0574634579949, 835.6156168162645, 13371.59885203443, 14898.702025959474, 15288.159151246677, 15515.68968620627, 15626.984246024, 14341.498047568337, 14584.489542866002, 14620.195889226088, 14648.194349310783, 14648.780268295985, 929.8372784762656, 958.156821996642, 963.2631037256505, 965.4159233663603, 970.2674480767012, 827.8178800663844, 934.8971613122551, 957.1529196660936, 962.7785609309863, 978.9510524473783, 1019.1286450085181, 1037.3827572594294, 1040.599369242843, 1043.6608102366724, 1046.4192373232852, 1012.3824467075078, 1023.5240613114863, 1027.650598796409, 1029.5984566019258, 1030.1243942648764, 759.3317880265331, 770.6917233106747, 772.0773675457774, 772.9652165652559, 774.3456779021718, 15913.20433978308, 15968.76046859298, 16557.420490282904, 16664.83335166645, 16907.0, 14224.573262802132, 14898.851011489854, 14971.775423368657, 15049.172295523742, 15666.903316767832, 11446.542138314457, 11607.053801192902, 11709.94145029278, 11732.061435085257, 11851.288922664582, 3652.9086772830624, 3668.6147954464664, 3699.505511639526, 3735.1035751419736, 3895.357266051098, 112865.43567282193, 113580.43209783899, 113659.43170284096, 114590.0, 116399.0, 11335.263207891461, 11443.141764367705, 11835.526578936919, 11883.227590206781, 11900.285982841056, 24299.39251518726, 24914.12800551972, 25215.495690086464, 25224.0, 25249.62125568118, 7793.688252469951, 7849.960750196326, 7975.242351976669, 8025.0, 8128.0, 4136.358864376027, 4201.663866890642, 4214.536400995888, 4246.087091275391, 4248.362745588187, 3427.417339052367, 3477.3566890125408, 3493.7729047611824, 3508.1755787389943, 3517.50754894315, 624.2384291164772, 628.3779058731914, 634.1977398590786, 641.2977789320686, 643.5077165968038, 643.530222937249, 652.8857449946336, 672.5527524196452, 701.9929800701927, 725.6553137259759, 9847.852282215772, 10037.841863999129, 10114.494275286206, 10152.340097893613, 10431.634892778717, 617.7528988404674, 656.0351746519206, 675.6284043776002, 694.1046050594676, 698.4098436820879, 4644.744539050317, 4898.632602554751, 4924.1875090610365, 4933.432655244621, 4946.1344264753525, 98791.0, 98869.66389873427, 99679.50160249152, 100566.49716751369, 101878.98121018695, 86148.0, 86618.13381866101, 87925.56037219772, 88476.0, 88484.6727299091, 63370.09889703316, 73811.89282160772, 74589.0, 75280.24719752841, 75384.24615753882, 8517.914820851713, 8914.955425222832, 9013.84459981383, 9359.0, 9486.715398538056, 43772.56227437812, 47239.29141062956, 47977.56067317986, 48370.758146209046, 48478.757606213156, 60379.0, 60835.78328433318, 61075.389246108745, 61129.0, 61159.388406115366, 11681.415929203677, 11865.940670296593, 12484.250944943333, 13087.0, 14302.642433938818, 14608.123512589278, 14623.707525849637, 14797.440938987856, 14842.232528640137, 14916.552503424915, 13326.800097998344, 13473.915779355462, 13531.255780932142, 13790.65523361924, 14523.838092952326, 12311.322877241837, 13761.783801857477, 13816.309184540532, 13927.791083133558, 14193.645158871112, 12831.602654814447, 12973.0, 13038.608841734764, 13269.402876870758, 13488.190708557519, 9859.0, 10456.477176141314, 11181.32912025281, 11210.943945280222, 11616.128790340927, 7743.57410342414, 8460.362044321, 10139.246983313355, 10556.935579801679, 11151.72120696989], "value": 7608.431856057476, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 184.0, 157.0, 129.0, 180.0, 121.0, 123.0, 118.0, 121.0, 113.0], "value": 136.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 114.0, 157.0, 121.0, 110.0, 115.0, 118.0, 137.0, 117.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 217.0, 264.0, 248.0, 201.0, 196.0, 202.0, 198.0, 196.0, 192.0], "value": 211.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 62.0, 86.0, 59.0, 62.0, 62.0, 73.0, 76.0, 61.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 86.0, 70.0, 71.0, 70.0, 85.0, 70.0, 73.0, 84.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 88.0, 88.0, 114.0, 88.0, 98.0, 115.0, 88.0, 89.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 100.0, 142.0, 119.0, 155.0, 147.0, 96.0, 97.0, 96.0, 94.0], "value": 117.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 90.0, 79.0, 141.0, 146.0, 90.0, 90.0, 123.0, 85.0], "value": 102.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 66.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 66.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 69.0, 87.0, 95.0, 88.0, 58.0, 59.0, 60.0, 59.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 111.0, 106.0, 84.0, 84.0, 86.0, 75.0, 86.0, 100.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 148.0, 148.0, 155.0, 129.0, 139.0, 142.0, 135.0, 201.0, 158.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 190.0, 187.0, 188.0, 190.0, 184.0, 189.0, 190.0, 183.0, 185.0], "value": 187.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 67.0, 71.0], "value": 68.4, "unit": "score"}]}]} 15:39:33 INFO - Return code: 0 15:39:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:39:33 ERROR - # TBPL SUCCESS # 15:39:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:39:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:39:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:39:33 INFO - 2017-03-16 15:39:33.568 screenresolution[1928:17888] starting screenresolution argv=screenresolution get 15:39:33 INFO - 2017-03-16 15:39:33.571 screenresolution[1928:17888] Display 0: 1600x1200x32@60 15:39:33 INFO - 2017-03-16 15:39:33.577 screenresolution[1929:17891] starting screenresolution argv=screenresolution list 15:39:33 INFO - Available Modes on Display 0 15:39:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:39:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:39:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:39:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:39:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:39:33 INFO - Intel Iris: 15:39:33 INFO - Chipset Model: Intel Iris 15:39:33 INFO - Type: GPU 15:39:33 INFO - Bus: Built-In 15:39:33 INFO - VRAM (Dynamic, Max): 1536 MB 15:39:33 INFO - Vendor: Intel (0x8086) 15:39:33 INFO - Device ID: 0x0a2e 15:39:33 INFO - Revision ID: 0x0009 15:39:33 INFO - Displays: 15:39:33 INFO - Display: 15:39:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:39:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:39:33 INFO - Display Serial Number: 1600x1200 60 15:39:33 INFO - Main Display: Yes 15:39:33 INFO - Mirror: Off 15:39:33 INFO - Online: Yes 15:39:33 INFO - Rotation: Supported 15:39:33 INFO - Return code: 0 15:39:33 INFO - Running post-action listener: _resource_record_post_action 15:39:33 INFO - [mozharness: 2017-03-16 22:39:33.818068Z] Finished run-tests step (success) 15:39:33 INFO - Running post-run listener: _resource_record_post_run 15:39:33 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 1362944; Write bytes: 515213824; Read time: 34; Write time: 1582 15:39:33 INFO - TinderboxPrint: CPU usage
54.2% 15:39:33 INFO - TinderboxPrint: I/O read bytes / time
1,362,944 / 34 15:39:33 INFO - TinderboxPrint: I/O write bytes / time
515,213,824 / 1,582 15:39:33 INFO - TinderboxPrint: CPU idle
2,201.2 (45.8%) 15:39:33 INFO - TinderboxPrint: CPU system
964.4 (20.1%) 15:39:33 INFO - TinderboxPrint: CPU user
1,635.9 (34.1%) 15:39:33 INFO - TinderboxPrint: Swap in / out
211,968,000 / 0 15:39:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205492736; Write bytes: 204285952; Read time: 15719; Write time: 436 15:39:33 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1362944; Write bytes: 300048896; Read time: 34; Write time: 1113 15:39:34 INFO - Running post-run listener: _upload_blobber_files 15:39:34 INFO - Blob upload gear active. 15:39:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:39:34 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 15:39:34 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'] 15:39:34 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 15:39:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:39:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:39:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:35 INFO - (blobuploader) - INFO - Done attempting. 15:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:36 INFO - (blobuploader) - INFO - Done attempting. 15:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:37 INFO - (blobuploader) - INFO - Done attempting. 15:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:39 INFO - (blobuploader) - INFO - Done attempting. 15:39:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:39 INFO - Return code: 0 15:39:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:39:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1bf66d9d19d32e41f018bd211090f443f7dc0fa459749c170bcd24625f9b6752a5e96b233bf2b4e08e8da54aab87be8fb09f87041791f1b52c6baf0fc9313e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982cbabe4344663c1ba21929d2a3867d5e72e29dd09342e93bafa2016d58e0c60e3459872f071279e98208d8bfa57ff98e73e08976e3aa9f6d20bbdaa12e33b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e468497b9c6665df73d787ba3f0779bc20e72c3264630fb7a60e63db628e318fdb88ac05882885e446a847aadac6a263fcab0a1b883e5e7a22fc3796517fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7533a62c50d3c01437c343a70b9cc15790553fce13340976b68f6a2f58cf901b8813f65aa802c6f6a92bf0ef54727329180641f0feaffed5738e145d42cfb635"} 15:39:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:39:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:39:39 INFO - Contents: 15:39:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1bf66d9d19d32e41f018bd211090f443f7dc0fa459749c170bcd24625f9b6752a5e96b233bf2b4e08e8da54aab87be8fb09f87041791f1b52c6baf0fc9313e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982cbabe4344663c1ba21929d2a3867d5e72e29dd09342e93bafa2016d58e0c60e3459872f071279e98208d8bfa57ff98e73e08976e3aa9f6d20bbdaa12e33b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e468497b9c6665df73d787ba3f0779bc20e72c3264630fb7a60e63db628e318fdb88ac05882885e446a847aadac6a263fcab0a1b883e5e7a22fc3796517fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7533a62c50d3c01437c343a70b9cc15790553fce13340976b68f6a2f58cf901b8813f65aa802c6f6a92bf0ef54727329180641f0feaffed5738e145d42cfb635"} 15:39:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:39 INFO - Copying logs to upload dir... 15:39:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:39:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.999414 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-16 15:39:39.659768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 15:39:39.664095) ========= 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.Z1fIMLE9fo/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.p18CqtGyga/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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/6c1bf66d9d19d32e41f018bd211090f443f7dc0fa459749c170bcd24625f9b6752a5e96b233bf2b4e08e8da54aab87be8fb09f87041791f1b52c6baf0fc9313e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982cbabe4344663c1ba21929d2a3867d5e72e29dd09342e93bafa2016d58e0c60e3459872f071279e98208d8bfa57ff98e73e08976e3aa9f6d20bbdaa12e33b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e468497b9c6665df73d787ba3f0779bc20e72c3264630fb7a60e63db628e318fdb88ac05882885e446a847aadac6a263fcab0a1b883e5e7a22fc3796517fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7533a62c50d3c01437c343a70b9cc15790553fce13340976b68f6a2f58cf901b8813f65aa802c6f6a92bf0ef54727329180641f0feaffed5738e145d42cfb635"} build_url:https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/Zm-o439BR5GkBETKmaltwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1bf66d9d19d32e41f018bd211090f443f7dc0fa459749c170bcd24625f9b6752a5e96b233bf2b4e08e8da54aab87be8fb09f87041791f1b52c6baf0fc9313e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982cbabe4344663c1ba21929d2a3867d5e72e29dd09342e93bafa2016d58e0c60e3459872f071279e98208d8bfa57ff98e73e08976e3aa9f6d20bbdaa12e33b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e468497b9c6665df73d787ba3f0779bc20e72c3264630fb7a60e63db628e318fdb88ac05882885e446a847aadac6a263fcab0a1b883e5e7a22fc3796517fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7533a62c50d3c01437c343a70b9cc15790553fce13340976b68f6a2f58cf901b8813f65aa802c6f6a92bf0ef54727329180641f0feaffed5738e145d42cfb635"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 15:39:39.698945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:39:39.699300) ========= 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.Z1fIMLE9fo/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.p18CqtGyga/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005283 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:39:39.748321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 15:39:39.748669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 15:39:39.749024) ========= ========= Total master_lag: 2.94 =========