builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0247 starttime: 1472266340.04 results: success (0) buildid: 20160826163414 builduid: 64d1a37c61f644b88b7ca024b6f355d1 revision: 3c4c4accb1392bbc70fed3ddebbaa42453963900 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.035610) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.036118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.036850) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.115012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.115331) ========= 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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-26 19:52:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.2M=0.001s 2016-08-26 19:52:20 (10.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.508773 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.651772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.652137) ========= 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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.020862 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:20.701541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 19:52:20.701935) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c4c4accb1392bbc70fed3ddebbaa42453963900 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3c4c4accb1392bbc70fed3ddebbaa42453963900 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TZuM9PFHsP/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.w8oDT1xHGG/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-26 19:52:20,790 truncating revision to first 12 chars 2016-08-26 19:52:20,790 Setting DEBUG logging. 2016-08-26 19:52:20,790 attempt 1/10 2016-08-26 19:52:20,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c4c4accb139?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 19:52:21,884 unpacking tar archive at: fx-team-3c4c4accb139/testing/mozharness/ program finished with exit code 0 elapsedTime=1.350803 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 19:52:22.080211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:22.080584) ========= script_repo_revision: 3c4c4accb1392bbc70fed3ddebbaa42453963900 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:22.081046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:22.081427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 19:52:22.103317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-26 19:52:22.104072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TZuM9PFHsP/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.w8oDT1xHGG/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:52:22 INFO - MultiFileLogger online at 20160826 19:52:22 in /builds/slave/test 19:52:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:52:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:52:22 INFO - {'append_to_log': False, 19:52:22 INFO - 'base_work_dir': '/builds/slave/test', 19:52:22 INFO - 'blob_upload_branch': 'Fx-Team', 19:52:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:52:22 INFO - 'branch': 'Fx-Team', 19:52:22 INFO - 'buildbot_json_path': 'buildprops.json', 19:52:22 INFO - 'config_files': ('talos/mac_config.py',), 19:52:22 INFO - 'default_actions': ('clobber', 19:52:22 INFO - 'read-buildbot-config', 19:52:22 INFO - 'download-and-extract', 19:52:22 INFO - 'populate-webroot', 19:52:22 INFO - 'create-virtualenv', 19:52:22 INFO - 'install', 19:52:22 INFO - 'run-tests'), 19:52:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:52:22 INFO - 'download_minidump_stackwalk': True, 19:52:22 INFO - 'download_symbols': 'ondemand', 19:52:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:52:22 INFO - 'tooltool.py': '/tools/tooltool.py', 19:52:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:52:22 INFO - '/tools/misc-python/virtualenv.py')}, 19:52:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:52:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:52:22 INFO - 'installer_path': 'installer.exe', 19:52:22 INFO - 'log_level': 'info', 19:52:22 INFO - 'log_name': 'talos', 19:52:22 INFO - 'log_to_console': True, 19:52:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:52:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:52:22 INFO - 'opt_config_files': (), 19:52:22 INFO - 'pip_index': False, 19:52:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:52:22 INFO - 'cmd': ('bash', 19:52:22 INFO - '-c', 19:52:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:52:22 INFO - 'enabled': True, 19:52:22 INFO - 'halt_on_failure': False, 19:52:22 INFO - 'name': 'check_screen_resolution'},), 19:52:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:52:22 INFO - 'cmd': ('bash', 19:52:22 INFO - '-c', 19:52:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:52:22 INFO - 'enabled': True, 19:52:22 INFO - 'halt_on_failure': False, 19:52:22 INFO - 'name': 'check_screen_resolution'},), 19:52:22 INFO - 'run_cmd_checks_enabled': True, 19:52:22 INFO - 'sps_profile': False, 19:52:22 INFO - 'sps_profile_interval': 0, 19:52:22 INFO - 'suite': 'dromaeojs-e10s', 19:52:22 INFO - 'system_bits': '32', 19:52:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:52:22 INFO - 'title': 't-yosemite-r7-0247', 19:52:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:52:22 INFO - 'use_talos_json': True, 19:52:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:52:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:52:22 INFO - 'work_dir': 'build'} 19:52:22 INFO - [mozharness: 2016-08-27 02:52:22.304587Z] Running clobber step. 19:52:22 INFO - Running pre-action listener: _resource_record_pre_action 19:52:22 INFO - Running main action method: clobber 19:52:22 INFO - rmtree: /builds/slave/test/build 19:52:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:52:24 INFO - Running post-action listener: _resource_record_post_action 19:52:24 INFO - [mozharness: 2016-08-27 02:52:24.520968Z] Finished clobber step (success) 19:52:24 INFO - [mozharness: 2016-08-27 02:52:24.521107Z] Running read-buildbot-config step. 19:52:24 INFO - Running pre-action listener: _resource_record_pre_action 19:52:24 INFO - Running main action method: read_buildbot_config 19:52:24 INFO - Using buildbot properties: 19:52:24 INFO - { 19:52:24 INFO - "project": "", 19:52:24 INFO - "product": "firefox", 19:52:24 INFO - "script_repo_revision": "production", 19:52:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 19:52:24 INFO - "repository": "", 19:52:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 19:52:24 INFO - "buildid": "20160826163414", 19:52:24 INFO - "pgo_build": "False", 19:52:24 INFO - "basedir": "/builds/slave/test", 19:52:24 INFO - "buildnumber": 103, 19:52:24 INFO - "slavename": "t-yosemite-r7-0247", 19:52:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:52:24 INFO - "platform": "yosemite_r7", 19:52:24 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 19:52:24 INFO - "branch": "fx-team", 19:52:24 INFO - "repo_path": "integration/fx-team", 19:52:24 INFO - "revision": "3c4c4accb1392bbc70fed3ddebbaa42453963900", 19:52:24 INFO - "stage_platform": "macosx64", 19:52:24 INFO - "builduid": "64d1a37c61f644b88b7ca024b6f355d1", 19:52:24 INFO - "slavebuilddir": "test" 19:52:24 INFO - } 19:52:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:52:24 INFO - Running post-action listener: _resource_record_post_action 19:52:24 INFO - [mozharness: 2016-08-27 02:52:24.524352Z] Finished read-buildbot-config step (success) 19:52:24 INFO - [mozharness: 2016-08-27 02:52:24.524504Z] Running download-and-extract step. 19:52:24 INFO - Running pre-action listener: _resource_record_pre_action 19:52:24 INFO - Running main action method: download_and_extract 19:52:24 INFO - mkdir: /builds/slave/test/build/tests 19:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:24 INFO - trying https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:52:24 INFO - Downloading https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 19:52:26 INFO - Downloaded 1199 bytes. 19:52:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:52:26 INFO - Using the following test package requirements: 19:52:26 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:52:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:52:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:52:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'jsshell-mac.zip'], 19:52:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:52:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:52:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:52:26 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:52:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:52:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:52:26 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:52:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:52: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')]} 19:52:26 INFO - trying https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:52:26 INFO - Downloading https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:52:27 INFO - Downloaded 16369419 bytes. 19:52:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:52:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:52:33 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')]} 19:52:33 INFO - trying https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:52:33 INFO - Downloading https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:52:34 INFO - Downloaded 16369419 bytes. 19:52:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:41 INFO - trying https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:52:41 INFO - Downloading https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:52:42 INFO - Downloaded 14413998 bytes. 19:52:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 19:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:42 INFO - trying https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:52:42 INFO - Downloading https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 19:52:46 INFO - Downloaded 111552867 bytes. 19:52:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:52:46 INFO - mkdir: /builds/slave/test/properties 19:52:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:52:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:52:46 INFO - Contents: 19:52:46 INFO - build_url:https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:52:46 INFO - Running post-action listener: _resource_record_post_action 19:52:46 INFO - Running post-action listener: set_extra_try_arguments 19:52:46 INFO - [mozharness: 2016-08-27 02:52:46.795048Z] Finished download-and-extract step (success) 19:52:46 INFO - [mozharness: 2016-08-27 02:52:46.795183Z] Running populate-webroot step. 19:52:46 INFO - Running pre-action listener: _resource_record_pre_action 19:52:46 INFO - Running main action method: populate_webroot 19:52:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:52:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:52:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:52:46 INFO - '--tppagecycles', 19:52:46 INFO - '7'], 19:52:46 INFO - 'tests': ['tsvgm']}}, 19:52:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:52:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:52:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:52:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:52:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:52:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:52:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['damp', 'tps']}, 19:52:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'tests': ['damp', 'tps']}, 19:52:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['dromaeo_dom']}, 19:52:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:52:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['basic_compositor_video']}, 19:52:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:52:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['a11yr', 19:52:46 INFO - 'ts_paint', 19:52:46 INFO - 'tpaint', 19:52:46 INFO - 'sessionrestore', 19:52:46 INFO - 'sessionrestore_no_auto_restore', 19:52:46 INFO - 'tabpaint']}, 19:52:46 INFO - 'other-e10s': {'tests': ['a11yr', 19:52:46 INFO - 'ts_paint', 19:52:46 INFO - 'tpaint', 19:52:46 INFO - 'sessionrestore', 19:52:46 INFO - 'sessionrestore_no_auto_restore', 19:52:46 INFO - 'tabpaint']}, 19:52:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:52:46 INFO - 'ts_paint', 19:52:46 INFO - 'tpaint', 19:52:46 INFO - 'sessionrestore', 19:52:46 INFO - 'sessionrestore_no_auto_restore', 19:52:46 INFO - 'tabpaint']}, 19:52:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:52:46 INFO - 'ts_paint', 19:52:46 INFO - 'tpaint', 19:52:46 INFO - 'sessionrestore', 19:52:46 INFO - 'sessionrestore_no_auto_restore', 19:52:46 INFO - 'tabpaint']}, 19:52:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['a11yr', 19:52:46 INFO - 'ts_paint', 19:52:46 INFO - 'tpaint', 19:52:46 INFO - 'sessionrestore', 19:52:46 INFO - 'sessionrestore_no_auto_restore', 19:52:46 INFO - 'tabpaint']}, 19:52:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['a11yr', 19:52:46 INFO - 'ts_paint', 19:52:46 INFO - 'tpaint', 19:52:46 INFO - 'sessionrestore', 19:52:46 INFO - 'sessionrestore_no_auto_restore', 19:52:46 INFO - 'tabpaint']}, 19:52:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['tsvgx', 19:52:46 INFO - 'tsvgr_opacity', 19:52:46 INFO - 'tart', 19:52:46 INFO - 'tscrollx', 19:52:46 INFO - 'cart']}, 19:52:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:52:46 INFO - 'tsvgr_opacity', 19:52:46 INFO - 'tart', 19:52:46 INFO - 'tscrollx', 19:52:46 INFO - 'cart']}, 19:52:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'talos_options': ['--disable-e10s'], 19:52:46 INFO - 'tests': ['tp5o']}, 19:52:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'tests': ['tp5o']}, 19:52:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'talos_options': ['--disable-e10s', 19:52:46 INFO - '--xperf_path', 19:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:52:46 INFO - 'tests': ['tp5n']}, 19:52:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:52:46 INFO - 'talos_options': ['--xperf_path', 19:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:52:46 INFO - 'tests': ['tp5n']}}, 19:52:46 INFO - 'talos.zip': {'path': '', 19:52:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:52:46 INFO - Running post-action listener: _resource_record_post_action 19:52:46 INFO - [mozharness: 2016-08-27 02:52:46.814116Z] Finished populate-webroot step (success) 19:52:46 INFO - [mozharness: 2016-08-27 02:52:46.814204Z] Running create-virtualenv step. 19:52:46 INFO - Running pre-action listener: _resource_record_pre_action 19:52:46 INFO - Running main action method: create_virtualenv 19:52:46 INFO - Creating virtualenv /builds/slave/test/build/venv 19:52:46 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 19:52:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:52:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:52:46 INFO - Using real prefix '/tools/python27' 19:52:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:52:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:52:50 INFO - Installing pip.................done. 19:52:50 INFO - Return code: 0 19:52:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:52:50 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')]} 19:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:50 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')]} 19:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:50 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:52:50 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 19:52:50 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 19:52:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:52:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:52:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:52:50 INFO - 'HOME': '/Users/cltbld', 19:52:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:52:50 INFO - 'LOGNAME': 'cltbld', 19:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:50 INFO - 'MOZ_NO_REMOTE': '1', 19:52:50 INFO - 'NO_EM_RESTART': '1', 19:52:50 INFO - 'PAGER': '/bin/cat', 19:52:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:50 INFO - 'PWD': '/builds/slave/test', 19:52:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:52:50 INFO - 'SHELL': '/bin/bash', 19:52:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:52:50 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:52:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:52:50 INFO - 'USER': 'cltbld', 19:52:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:52:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:50 INFO - 'XPC_FLAGS': '0x0', 19:52:50 INFO - 'XPC_SERVICE_NAME': '0', 19:52:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:50 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 19:52:50 INFO - Cleaning up... 19:52:50 INFO - Return code: 0 19:52:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:52:50 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')]} 19:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:50 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')]} 19:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:50 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:52:50 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 19:52:50 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 19:52:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:52:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:52:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:52:50 INFO - 'HOME': '/Users/cltbld', 19:52:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:52:50 INFO - 'LOGNAME': 'cltbld', 19:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:50 INFO - 'MOZ_NO_REMOTE': '1', 19:52:50 INFO - 'NO_EM_RESTART': '1', 19:52:50 INFO - 'PAGER': '/bin/cat', 19:52:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:50 INFO - 'PWD': '/builds/slave/test', 19:52:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:52:50 INFO - 'SHELL': '/bin/bash', 19:52:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:52:50 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:52:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:52:50 INFO - 'USER': 'cltbld', 19:52:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:52:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:50 INFO - 'XPC_FLAGS': '0x0', 19:52:50 INFO - 'XPC_SERVICE_NAME': '0', 19:52:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:51 INFO - Downloading/unpacking psutil>=3.1.1 19:52:51 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 19:52:51 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 19:52:51 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 19:52:51 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 19:52:51 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 19:52:51 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 19:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:52:54 INFO - Installing collected packages: psutil 19:52:54 INFO - Running setup.py install for psutil 19:52:54 INFO - building 'psutil._psutil_osx' extension 19:52:54 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 19:52:54 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 19:52:54 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 19:52:55 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 19:52:55 INFO - building 'psutil._psutil_posix' extension 19:52:55 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 19:52:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:52:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:52:55 INFO - ^ 19:52:55 INFO - 1 warning generated. 19:52:55 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 19:52:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:52:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:52:55 INFO - Successfully installed psutil 19:52:55 INFO - Cleaning up... 19:52:55 INFO - Return code: 0 19:52:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:52:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:52:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:52:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:52:55 INFO - 'HOME': '/Users/cltbld', 19:52:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:52:55 INFO - 'LOGNAME': 'cltbld', 19:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:55 INFO - 'MOZ_NO_REMOTE': '1', 19:52:55 INFO - 'NO_EM_RESTART': '1', 19:52:55 INFO - 'PAGER': '/bin/cat', 19:52:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:55 INFO - 'PWD': '/builds/slave/test', 19:52:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:52:55 INFO - 'SHELL': '/bin/bash', 19:52:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:52:55 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:52:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:52:55 INFO - 'USER': 'cltbld', 19:52:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:52:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:55 INFO - 'XPC_FLAGS': '0x0', 19:52:55 INFO - 'XPC_SERVICE_NAME': '0', 19:52:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:52:55 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 19:52:55 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 19:52:55 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 19:52:55 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 19:52:55 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 19:52:55 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 19:52:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:52:58 INFO - Installing collected packages: mozsystemmonitor 19:52:58 INFO - Running setup.py install for mozsystemmonitor 19:52:58 INFO - Successfully installed mozsystemmonitor 19:52:58 INFO - Cleaning up... 19:52:58 INFO - Return code: 0 19:52:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:58 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:52:58 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 19:52:58 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 19:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:52:58 INFO - 'HOME': '/Users/cltbld', 19:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:52:58 INFO - 'LOGNAME': 'cltbld', 19:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:58 INFO - 'MOZ_NO_REMOTE': '1', 19:52:58 INFO - 'NO_EM_RESTART': '1', 19:52:58 INFO - 'PAGER': '/bin/cat', 19:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:58 INFO - 'PWD': '/builds/slave/test', 19:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:52:58 INFO - 'SHELL': '/bin/bash', 19:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:52:58 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:52:58 INFO - 'USER': 'cltbld', 19:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:58 INFO - 'XPC_FLAGS': '0x0', 19:52:58 INFO - 'XPC_SERVICE_NAME': '0', 19:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:58 INFO - Downloading/unpacking jsonschema==2.5.1 19:52:58 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 19:52:58 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 19:52:58 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 19:52:58 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 19:52:58 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 19:52:58 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 19:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:53:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:53:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:53:01 INFO - warning: no files found matching '*.txt' 19:53:01 INFO - no previously-included directories found matching 'build' 19:53:01 INFO - no previously-included directories found matching 'dist' 19:53:01 INFO - no previously-included directories found matching '.git*' 19:53:01 INFO - Installing collected packages: jsonschema, functools32 19:53:01 INFO - Running setup.py install for functools32 19:53:01 INFO - warning: no files found matching '*.txt' 19:53:01 INFO - no previously-included directories found matching 'build' 19:53:01 INFO - no previously-included directories found matching 'dist' 19:53:01 INFO - no previously-included directories found matching '.git*' 19:53:01 INFO - Successfully installed jsonschema functools32 19:53:01 INFO - Cleaning up... 19:53:01 INFO - Return code: 0 19:53:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:53:01 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')]} 19:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:01 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')]} 19:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:01 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:53:01 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 19:53:01 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 19:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:53:01 INFO - 'HOME': '/Users/cltbld', 19:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:53:01 INFO - 'LOGNAME': 'cltbld', 19:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:01 INFO - 'MOZ_NO_REMOTE': '1', 19:53:01 INFO - 'NO_EM_RESTART': '1', 19:53:01 INFO - 'PAGER': '/bin/cat', 19:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:01 INFO - 'PWD': '/builds/slave/test', 19:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:53:01 INFO - 'SHELL': '/bin/bash', 19:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:53:01 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:53:01 INFO - 'USER': 'cltbld', 19:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:01 INFO - 'XPC_FLAGS': '0x0', 19:53:01 INFO - 'XPC_SERVICE_NAME': '0', 19:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:53:02 INFO - Cleaning up... 19:53:02 INFO - Return code: 0 19:53:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:53:02 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')]} 19:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:02 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')]} 19:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:02 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:53:02 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 19:53:02 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 19:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:53:02 INFO - 'HOME': '/Users/cltbld', 19:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:53:02 INFO - 'LOGNAME': 'cltbld', 19:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:02 INFO - 'MOZ_NO_REMOTE': '1', 19:53:02 INFO - 'NO_EM_RESTART': '1', 19:53:02 INFO - 'PAGER': '/bin/cat', 19:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:02 INFO - 'PWD': '/builds/slave/test', 19:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:53:02 INFO - 'SHELL': '/bin/bash', 19:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:53:02 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:53:02 INFO - 'USER': 'cltbld', 19:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:02 INFO - 'XPC_FLAGS': '0x0', 19:53:02 INFO - 'XPC_SERVICE_NAME': '0', 19:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:53:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:53:02 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 19:53:02 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 19:53:02 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 19:53:02 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 19:53:02 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 19:53:02 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 19:53:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:53:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:53: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 19:53: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 19:53: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 19:53: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 19:53: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 19:53: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 19:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:53:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:53:05 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 19:53:05 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 19:53:05 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 19:53:05 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 19:53:05 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 19:53:05 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 19:53:05 INFO - Downloading docopt-0.6.1.tar.gz 19:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:53:06 INFO - Installing collected packages: blobuploader, requests, docopt 19:53:06 INFO - Running setup.py install for blobuploader 19:53:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:53:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:53:06 INFO - Running setup.py install for requests 19:53:06 INFO - Running setup.py install for docopt 19:53:06 INFO - Successfully installed blobuploader requests docopt 19:53:06 INFO - Cleaning up... 19:53:06 INFO - Return code: 0 19:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:06 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:53:06 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 19:53:06 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 19:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:53:06 INFO - 'HOME': '/Users/cltbld', 19:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:53:06 INFO - 'LOGNAME': 'cltbld', 19:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:06 INFO - 'MOZ_NO_REMOTE': '1', 19:53:06 INFO - 'NO_EM_RESTART': '1', 19:53:06 INFO - 'PAGER': '/bin/cat', 19:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:06 INFO - 'PWD': '/builds/slave/test', 19:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:53:06 INFO - 'SHELL': '/bin/bash', 19:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:53:06 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:53:06 INFO - 'USER': 'cltbld', 19:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:06 INFO - 'XPC_FLAGS': '0x0', 19:53:06 INFO - 'XPC_SERVICE_NAME': '0', 19:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-DAJ1MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-EPGxSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-3q11Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-r0tmIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-U0rZFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-WuWxGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-kpeFzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:53:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-03fDVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Y3Gn9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-FldSza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-t02ucc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-LbUP_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-UolY29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-qG9Buu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-KD6w2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-D0IhJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:53:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-5prc8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:53:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:53:08 INFO - Running setup.py install for manifestparser 19:53:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:53:09 INFO - Running setup.py install for mozcrash 19:53:09 INFO - Running setup.py install for mozdebug 19:53:09 INFO - Running setup.py install for mozdevice 19:53:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:53:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:53:09 INFO - Running setup.py install for mozfile 19:53:09 INFO - Running setup.py install for mozhttpd 19:53:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:53:09 INFO - Running setup.py install for mozinfo 19:53:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Running setup.py install for mozInstall 19:53:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Running setup.py install for mozleak 19:53:10 INFO - Running setup.py install for mozlog 19:53:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Running setup.py install for moznetwork 19:53:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Running setup.py install for mozprocess 19:53:10 INFO - Running setup.py install for mozprofile 19:53:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:53:10 INFO - Running setup.py install for mozrunner 19:53:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:53:11 INFO - Running setup.py install for mozscreenshot 19:53:11 INFO - Running setup.py install for moztest 19:53:11 INFO - Running setup.py install for mozversion 19:53:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:53:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:53:11 INFO - Cleaning up... 19:53:11 INFO - Return code: 0 19:53:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:11 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:53:11 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 19:53:11 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 19:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:53:11 INFO - 'HOME': '/Users/cltbld', 19:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:53:11 INFO - 'LOGNAME': 'cltbld', 19:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:11 INFO - 'MOZ_NO_REMOTE': '1', 19:53:11 INFO - 'NO_EM_RESTART': '1', 19:53:11 INFO - 'PAGER': '/bin/cat', 19:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:11 INFO - 'PWD': '/builds/slave/test', 19:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:53:11 INFO - 'SHELL': '/bin/bash', 19:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:53:11 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:53:11 INFO - 'USER': 'cltbld', 19:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:11 INFO - 'XPC_FLAGS': '0x0', 19:53:11 INFO - 'XPC_SERVICE_NAME': '0', 19:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:53:11 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-cjg7uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:53:11 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)) 19:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:53:11 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ccDvEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-zR6llx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:53:12 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)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-JYHxdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Zg6yHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:53:12 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)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-zWZajz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:53:12 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)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-vzSQjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:53:12 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)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-hfbJo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:53:12 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)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-fRRy2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:53:12 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)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-qg39yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-UC2yE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:53:12 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)) 19:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:53:12 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-NzedIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:53:13 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Hle_fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:53:13 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)) 19:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:53:13 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-UBULsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:53:13 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-OBRq4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:53:13 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)) 19:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:53:13 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-XVful9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:53:13 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-xE6_5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:53:13 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)) 19:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:53:13 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)) 19:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:53:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:53: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 19:53: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 19:53: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 19:53: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 19:53: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 19:53: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 19:53:16 INFO - Downloading blessings-1.6.tar.gz 19:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:53:16 INFO - Installing collected packages: blessings 19:53:16 INFO - Running setup.py install for blessings 19:53:16 INFO - Successfully installed blessings 19:53:16 INFO - Cleaning up... 19:53:16 INFO - Return code: 0 19:53:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:53:16 INFO - Reading from file tmpfile_stdout 19:53:16 INFO - Current package versions: 19:53:16 INFO - blessings == 1.6 19:53:16 INFO - blobuploader == 1.2.4 19:53:16 INFO - docopt == 0.6.1 19:53:16 INFO - functools32 == 3.2.3-2 19:53:16 INFO - jsonschema == 2.5.1 19:53:16 INFO - manifestparser == 1.1 19:53:16 INFO - mozInstall == 1.12 19:53:16 INFO - mozcrash == 0.17 19:53:16 INFO - mozdebug == 0.1 19:53:16 INFO - mozdevice == 0.48 19:53:16 INFO - mozfile == 1.2 19:53:16 INFO - mozhttpd == 0.7 19:53:16 INFO - mozinfo == 0.9 19:53:16 INFO - mozleak == 0.1 19:53:16 INFO - mozlog == 3.3 19:53:16 INFO - moznetwork == 0.27 19:53:16 INFO - mozprocess == 0.23 19:53:16 INFO - mozprofile == 0.28 19:53:16 INFO - mozrunner == 6.12 19:53:16 INFO - mozscreenshot == 0.1 19:53:16 INFO - mozsystemmonitor == 0.3 19:53:16 INFO - moztest == 0.7 19:53:16 INFO - mozversion == 1.4 19:53:16 INFO - psutil == 3.1.1 19:53:16 INFO - requests == 1.2.3 19:53:16 INFO - wsgiref == 0.1.2 19:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:53:16 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')]} 19:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:16 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')]} 19:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53:16 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 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:53:16 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 19:53:16 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 19:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:53:16 INFO - 'HOME': '/Users/cltbld', 19:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:53:16 INFO - 'LOGNAME': 'cltbld', 19:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:16 INFO - 'MOZ_NO_REMOTE': '1', 19:53:16 INFO - 'NO_EM_RESTART': '1', 19:53:16 INFO - 'PAGER': '/bin/cat', 19:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:16 INFO - 'PWD': '/builds/slave/test', 19:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:53:16 INFO - 'SHELL': '/bin/bash', 19:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:53:16 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:53:16 INFO - 'USER': 'cltbld', 19:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:16 INFO - 'XPC_FLAGS': '0x0', 19:53:16 INFO - 'XPC_SERVICE_NAME': '0', 19:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 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)) 19:53:17 INFO - Cleaning up... 19:53:17 INFO - Return code: 0 19:53:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:53: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')]} 19:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53: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')]} 19:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e527a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97bb5b5590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, '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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:53: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', 'jsonschema'] in /builds/slave/test/build 19:53: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 jsonschema 19:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:53:17 INFO - 'HOME': '/Users/cltbld', 19:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:53:17 INFO - 'LOGNAME': 'cltbld', 19:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:17 INFO - 'MOZ_NO_REMOTE': '1', 19:53:17 INFO - 'NO_EM_RESTART': '1', 19:53:17 INFO - 'PAGER': '/bin/cat', 19:53:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:17 INFO - 'PWD': '/builds/slave/test', 19:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:53:17 INFO - 'SHELL': '/bin/bash', 19:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:53:17 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:53:17 INFO - 'USER': 'cltbld', 19:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:17 INFO - 'XPC_FLAGS': '0x0', 19:53:17 INFO - 'XPC_SERVICE_NAME': '0', 19:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:53:17 INFO - Cleaning up... 19:53:17 INFO - Return code: 0 19:53:17 INFO - Running post-action listener: _resource_record_post_action 19:53:17 INFO - Running post-action listener: _start_resource_monitoring 19:53:17 INFO - Starting resource monitoring. 19:53:17 INFO - [mozharness: 2016-08-27 02:53:17.394037Z] Finished create-virtualenv step (success) 19:53:17 INFO - [mozharness: 2016-08-27 02:53:17.395125Z] Running install step. 19:53:17 INFO - Running pre-action listener: _resource_record_pre_action 19:53:17 INFO - Running main action method: install 19:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:53:17 INFO - Reading from file tmpfile_stdout 19:53:17 INFO - Detecting whether we're running mozinstall >=1.0... 19:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:53:17 INFO - Reading from file tmpfile_stdout 19:53:17 INFO - Output received: 19:53:17 INFO - Usage: mozinstall [options] installer 19:53:17 INFO - Options: 19:53:17 INFO - -h, --help show this help message and exit 19:53:17 INFO - -d DEST, --destination=DEST 19:53:17 INFO - Directory to install application into. [default: 19:53:17 INFO - "/builds/slave/test"] 19:53:17 INFO - --app=APP Application being installed. [default: firefox] 19:53:17 INFO - mkdir: /builds/slave/test/build/application 19:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:53:52 INFO - Reading from file tmpfile_stdout 19:53:52 INFO - Output received: 19:53:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:53:52 INFO - Running post-action listener: _resource_record_post_action 19:53:52 INFO - [mozharness: 2016-08-27 02:53:52.361740Z] Finished install step (success) 19:53:52 INFO - [mozharness: 2016-08-27 02:53:52.361887Z] Running run-tests step. 19:53:52 INFO - Running pre-action listener: _resource_record_pre_action 19:53:52 INFO - Running main action method: run_tests 19:53:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:53:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:53:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:53:52 INFO - 2016-08-26 19:53:52.376 screenresolution[2200:29708] starting screenresolution argv=screenresolution get 19:53:52 INFO - 2016-08-26 19:53:52.379 screenresolution[2200:29708] Display 0: 1600x1200x32@60 19:53:52 INFO - 2016-08-26 19:53:52.384 screenresolution[2201:29710] starting screenresolution argv=screenresolution list 19:53:52 INFO - Available Modes on Display 0 19:53:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:53:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:53:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:53:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:53:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:53:52 INFO - Intel Iris: 19:53:52 INFO - Chipset Model: Intel Iris 19:53:52 INFO - Type: GPU 19:53:52 INFO - Bus: Built-In 19:53:52 INFO - VRAM (Dynamic, Max): 1536 MB 19:53:52 INFO - Vendor: Intel (0x8086) 19:53:52 INFO - Device ID: 0x0a2e 19:53:52 INFO - Revision ID: 0x0009 19:53:52 INFO - Displays: 19:53:52 INFO - Display: 19:53:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:53:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:53:52 INFO - Display Serial Number: 1600x1200 60 19:53:52 INFO - Main Display: Yes 19:53:52 INFO - Mirror: Off 19:53:52 INFO - Online: Yes 19:53:52 INFO - Rotation: Supported 19:53:52 INFO - Return code: 0 19:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:53:52 INFO - Python 2.7.3 19:53:52 INFO - Return code: 0 19:53:52 INFO - grabbing minidump binary from tooltool 19:53:52 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')]} 19:53:52 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 0x10e48bd30>, '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 0x10e1f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e483b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:53:52 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 19:53:52 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 19:53:52 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 19:53:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:53:52 INFO - Return code: 0 19:53:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:53:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:53:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:53:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:53:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 19:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --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 19:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TZuM9PFHsP/Render', 19:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:53:52 INFO - 'HOME': '/Users/cltbld', 19:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:53:52 INFO - 'LOGNAME': 'cltbld', 19:53:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:53:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:52 INFO - 'MOZ_NO_REMOTE': '1', 19:53:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:53:52 INFO - 'NO_EM_RESTART': '1', 19:53:52 INFO - 'PAGER': '/bin/cat', 19:53:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:52 INFO - 'PWD': '/builds/slave/test', 19:53:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:53:52 INFO - 'SHELL': '/bin/bash', 19:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8oDT1xHGG/Listeners', 19:53:52 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:53:52 INFO - 'USER': 'cltbld', 19:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:52 INFO - 'XPC_FLAGS': '0x0', 19:53:52 INFO - 'XPC_SERVICE_NAME': '0', 19:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:53:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 19:53:52 INFO - mozversion application_buildid: 20160826163414 19:53:52 INFO - mozversion application_changeset: 3c4c4accb1392bbc70fed3ddebbaa42453963900 19:53:52 INFO - mozversion application_display_name: Nightly 19:53:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:53:52 INFO - mozversion application_name: Firefox 19:53:52 INFO - mozversion application_remotingname: firefox 19:53:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:53:52 INFO - mozversion application_vendor: Mozilla 19:53:52 INFO - mozversion application_version: 51.0a1 19:53:52 INFO - mozversion platform_buildid: 20160826163414 19:53:52 INFO - mozversion platform_changeset: 3c4c4accb1392bbc70fed3ddebbaa42453963900 19:53:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:53:52 INFO - mozversion platform_version: 51.0a1 19:53:52 INFO - using testdate: 1472266432 19:53:52 INFO - actual date: 1472266432 19:53:52 INFO - starting webserver on 'localhost:64069' 19:53:52 INFO - SUITE-START | Running 2 tests 19:53:52 INFO - TEST-START | dromaeo_css 19:53:52 INFO - operating with platform_type : mac_ 19:53:52 INFO - Initialising browser for dromaeo_css test... 19:53:52 INFO - TEST-INFO | started process 2211 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpQua_mk/profile http://localhost:64069/getInfo.html) 19:53:55 INFO - PROCESS | 2211 | __metrics Screen width/height:1600/1200 19:53:55 INFO - PROCESS | 2211 | colorDepth:24 19:53:55 INFO - PROCESS | 2211 | Browser inner width/height: 1024/689 19:53:55 INFO - PROCESS | 2211 | __metrics 19:53:55 ERROR - PROCESS | 2211 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 19:53:56 INFO - TEST-INFO | 2211: exit 0 19:53:56 INFO - Browser initialized. 19:53:56 INFO - Running cycle 1/1 for dromaeo_css test... 19:53:56 INFO - TEST-INFO | started process 2214 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpQua_mk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:54:08 INFO - PROCESS | 2214 | RSS: Main: 243785728 19:54:08 INFO - PROCESS | 2214 | 19:54:58 INFO - PROCESS | 2214 | 1472266498301 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:57:10 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:64069/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64069/tests/dromaeo/cssquery-ext.html) 19:57:12 INFO - PROCESS | 2214 | RSS: Main: 264577024 19:57:12 INFO - PROCESS | 2214 | 20:00:14 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:64069/tests/dromaeo/cssquery-ext.html (next: http://localhost:64069/tests/dromaeo/cssquery-jquery.html) 20:00:15 INFO - PROCESS | 2214 | RSS: Main: 272265216 20:00:15 INFO - PROCESS | 2214 | 20:03:17 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:64069/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64069/tests/dromaeo/cssquery-mootools.html) 20:03:17 INFO - PROCESS | 2214 | RSS: Main: 275083264 20:03:17 INFO - PROCESS | 2214 | 20:06:19 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:64069/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64069/tests/dromaeo/cssquery-prototype.html) 20:06:20 INFO - PROCESS | 2214 | RSS: Main: 271253504 20:06:20 INFO - PROCESS | 2214 | 20:09:23 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:64069/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64069/tests/dromaeo/cssquery-yui.html) 20:09:23 INFO - PROCESS | 2214 | RSS: Main: 276602880 20:09:23 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:64069/tests/dromaeo/cssquery-yui.html (next: http://localhost:64069/tests/dromaeo/cssquery-dojo.html) 20:12:26 INFO - PROCESS | 2214 | RSS: Main: 279441408 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | __start_tp_report 20:12:26 INFO - PROCESS | 2214 | _x_x_mozilla_page_load 20:12:26 INFO - PROCESS | 2214 | _x_x_mozilla_page_load_details 20:12:26 INFO - PROCESS | 2214 | |i|pagename|runs| 20:12:26 INFO - PROCESS | 2214 | |0;dojo.html;3414.28300056988;3414.4707570326577;3415.8292085395733;3421.3328400961823;3462.5152478652994;5532.944670553294;5789.102689083194;5844.7662093516265;5852.473277405033;5930.555208359379;4767.6424268179935;5193.324867767185;5765.740541675635;5780.132980052994;5797.130430435426;5164.922526162101;5257.474252574751;5301.3373328333955;5334.786608535654;5364.302640656709;5231.790728370861;5269.130593452076;5300.363956325227;5368.892622147555;5380.414453504893;5219.504147106038;5259.947400525984;5265.97313523863;5291.417944026154;5319.148936170213;5318.202269659543;5338.332708411449;5342.866428339284;5343.706096164709;5414.10667239905;5233.607479439019;5244.292020577212;5262.500062494095;5266.578673706133;5321.988822123784;5723.141528770676;5863.76544938202;5864.325602555718;5865.120231965197;5890.175375447441;6189.535784816157;6225.035119556476;6241.594296370721;6258.217722784652;6265.310815810257;6154.799814036265;6180.690965451754;6184.350643182446;6206.782762603332;6228.781992630282;5935.465808077293;5955.821325360246;5958.851028724316;5959.10613407988;6002.8499287517725;5452.672839629635;6423.857198987367;6431.260405053479;6454.160959075384;6496;6121.724522396503;6125.47964319526;6145.907811382833;6181.505479561624;6196.628202307876;6282.654454004982;6284.402981716729;6291.748330066837;6299.6535190564955;6312.495000399957;6099.237595300588;6225.066240063936;6233.96883015582;6252.062190671436;6252.468540174045;6096.7081148910665;6154.78458253959;6163.8150855474405;6203.689815509297;6216.689165541705;4308.827646894152;4994.525520075587;5003.399592048904;5007.7245751484015;5069.188929771219;4440.311751678495;4452.688311818207;4460.420145381079;4471.977640111843;4493.370928070073;4718.3158442025715;5053.787091098184;5340.359156901119;5999.820005399845;6002.579819412599;4739.502352253033;5387.595930305164;6041.969790151021;6081.331053584102;6304.180456540712;4382.99191186029;4685.461171965199;4736.8631528432925;5978.372270911578;6051.152838602599;5086.618503612244;5372.892542149135;5453.318335208099;5482.479164479368;5505.779768809202;5688.11834165705;6453.1610890583925;6454.386833250834;6469.51478639104;6497.252815926135;5232.215167724719;5943.435373639497;6192.195014648067;6242.035033359118;6264.248290205204;6236.314005459487;6363.077353783768;6416.358364163546;6420.743170273324;6456.2575303838785;6178.042403427476;6232.906506402317;6248.250209974832;6254.093156492374;6259.029850373017;6253.37466253371;6254.499640028877;6268.216472940882;6277.2153480814895;6298.71655775482;5016.799328026838;6027.21646185993;6069.2110025696375;6099.279518885317;6214.5960512566535;6146.907796383147;6156.569040167325;6159.81520554384;6167.444929956326;6207.875842483216;4957.380327459067;5924.555658325729;6028.764103358889;6094.695265236632;6113.877722445615;6092.482139018233;6114.297368146176;6118.4668989547035;6139.338817383189;6148.262208535004;6019.247594050744;6079.392060793885;6088.4824789893355;6099.542534309856;6118.143459915705 20:12:26 INFO - PROCESS | 2214 | |1;ext.html;478.0415267388887;489.7820469890899;494.56231235356745;524.3131497737963;526.897255035268;28814.991475298368;36757;40573.95695322852;40579.985500362505;40592.18815623686;41173.38239926403;41676.374854377136;41690.58309416905;41844.58155418445;41871;9593.136617704406;9764.658236961708;9798.755031124243;9803.264755143357;9854.40873547586;9687.757806054835;9759;9770.413775173512;9778.41329520231;9794.608215671364;9762.023797620252;9778.653123250404;9791.804163916753;9793.902060979406;9807.019298070207;9721;9737.56180971858;9750.804983900352;9751.17115045222;9759.609615615438;9612.807743845084;9694.612215511372;9721.854172187423;9721.951390243074;9723.416595004323;32377;38570.22859542821;39077.609223907966;39285.80357098225;39434;2911.781616378759;3566.5185199998186;3567.2687099144614;3854.8458061677497;3961.2473630010204;30731.846340768378;30998.535021974687;31174.84412577945;31285.217869553217;32218;3244;3292.2427841596327;3296.3407318536388;3359.6136444308972;3404.21703008307;286729;341562;347384;347895;348015.2599237013;33214;59867.401325987055;60192.699036505415;60194.69902650459;60317;34070.80752173662;34632.826835866166;34979;35194.76818311398;35221.64778352235;14276.500322488871;14453.421863125357;14548.854511454962;14607.269636518131;14633.317168525542;9724.708258752107;10868.293560918515;11218.934201250868;11402.030827379765;12294.323812190236;6534.836629084216;6571.57284776488;6746.347144949421;7700.460967732317;7857.528548287121;3181.2683082890603;3234.2399536108996;3236.741060715184;3246.302045060276;3272.1001724525468;849.8257857139272;875.6935072724496;910.4673765846921;970.427447805798;1044.4360045575456;28070.43859122847;28258.15225543237;30340.84829575838;30411.2397190072;30430.239244019078;1047.1413440978324;1078.1751959750798;1139.5327915554583;1139.9487023083982;1170.3563040327786;12938.741225175443;15457.613559660873;15639.296231669603;15901.800522379788;15938.203089845461;586010;642602;643364.9644524932;649054;650955;55174.44825551773;56253.71873140608;56308.718456407456;56391.15413268804;56482.43517564772;1324.602619214232;1358.3479929633634;1371.238962375871;1371.945122195121;1379.296558755022;25363.112291069723;27323.31691707723;27666;28748.568771468865;29724.554131687608;50189.24716129188;50753.23870141877;50795;50805.745971269906;50809.74595127001;462534;533036;541901;543163;546883;26558.601620976086;27088.593671094553;27101.780419881547;27115.1865444037;27162.185134445997;46761;46786.76606616945;47098;48176.7591162056;48344;38796.316106337035;38866.41700374553;38924.41613375745;39732.60267397405;40905.79547102245;38470.615293846706;38570.80714596409;39424;39505.604943950195;40022.79988600155;37950.43074353942;38026.429603555414;39212.803935981276;39721.80139099286;40299.395509067974;30463.847680761453;31111.911083111983;34553.82723086469;34852.47721284132;34909.65090349165;24330.51338973246;25463.21757477033;25487.36281592975;25988.350291242114;26184.607230891932 20:12:26 INFO - PROCESS | 2214 | |2;jquery.html;365.6380183618217;367.3919662957805;373.1473582863158;375.8064596732685;394.03854594788714;19441.611167776635;20290;20890.686639700416;21114.366569002934;21238.893805530988;11186.384748838811;11215.495302711377;11897.940510297436;11904.880951190486;11924.523019079226;5285.392179899303;5506.421825708303;5541.473560011793;5554.166874968747;5559.471850174227;3910.902227444308;5390.21841832934;5839.474447299742;6103.725332360033;6159.353267906872;5000.774965126559;5230.34620672416;6114.724837382306;6169.136320915076;6179;4563.794629241692;5107.90180111276;5376.220448035033;6154.846128846814;6161.9691901540655;4738.24188129901;5032.924506132411;5917.201177841022;6016.157737916695;6023.518118550505;11908.940455297754;12085.033197344192;12226;12232.755344893141;12253.203541769757;2027.432318950696;2079.812816846491;2088.385410182995;2169.53355028668;2919.3871485020786;9805.656802011896;10326;10370.481475926174;15309.464168754152;15462.690746185126;1704.6590681863677;1837.7886543047453;1857.609901920585;1876.3807943378652;1889.3576184097474;117992;120356.99999999913;126137;133773.33113334372;135154;11206.831897521544;11276.1542884284;11294.322340659586;11387.658370248906;11507.482163302671;14309.499167529086;14433;14455;14474.131552106906;14498.927505362406;8316.792080198044;8339.291160251325;8475.533845638425;8501.14988501145;8610.6986255482;7430.848218526137;8273.793155171168;8418.48045639524;8438.746837594881;8582.914170858336;3515.6308587598446;4471.552844715502;4490.820367185276;4500.8649740507835;4519.932201016987;1549.8915075944576;1628.1533602526856;1653.4956838164476;1887.339431199097;1931.278267906532;745.414849343263;907.7140700679265;923.4274749655123;936.2930987104828;995.5619527407918;15333.463328783439;19891;20415.387538373874;20774.58450830975;20784.960751962342;893.4862454088925;944.7213072143734;946.9715908522618;950.8858936927613;963.5182408795603;8784.60469278884;10458.63394781179;10673.505709200717;10902.454877256105;10937.945310273397;474929;562365;566433;577166;585355;132211.33894330467;133175;135696;138071;138291;904.4302089683457;943.4575119306427;957.6265256549951;959.8704174936433;967.8644989701447;10859;11316.37759923212;17906.925584464974;17962.5509362267;18825.623487530447;53320;54805.45194548163;55489;58195.54511137086;58896;81256;81997.21026502473;82089;82811.58594207231;84895.57552212199;12620.11659183885;12644.178128421623;12839.871601283867;12999.960003199532;13035.869641303465;13912.443502259795;13951.511697090553;14109.365078571695;14263;14427.92786036063;11553;11713.590024349107;12028.819567706667;12053.096017798876;12161.966232870305;9935.403875767188;10330.431826249629;10471.3193642413;11430.085593152695;11879;4705.905881882411;4707.764611769329;6689.8327541809895;7979.800504987422;8215.630296636546;10114.544845481823;10563.894361056598;11853.5851245206;12114.75770484603;12261.01911847068;11625.59310424131;11674.299542027506;11802.645920622395;12015.158938874545;12035.879641203475 20:12:26 INFO - PROCESS | 2214 | |3;mootools.html;1481.0669278354637;1507.9095254284741;1534.9462768803094;1740.2603893345324;1793.1751394358594;7745.535267883924;7881.605919704006;8383;8562.929633795775;8747.91252087479;8611.181937715923;8810.691625793082;8817.42686725364;8837.204651581356;8847.247983921374;2352.8941197646104;2371.490129622131;2383.2254517281867;2390.282915125464;2396.9640455393182;2365.775251351119;2378.595638741418;2409.0965887792077;2412.8431651942656;2416.996946267297;2376.8217383696206;2383.678203442539;2384.308550520347;2393.9521209575796;2394.940126496834;2345.2645042668473;2347.542229265294;2365.4677697518005;2371.2174982255815;2380.7619238076227;2327.7788610082016;2358.8112950964055;2360.78752912237;2362.161432691404;2365.976340236593;8876;8896.199342059246;8956.417832840845;8963.955180224057;8973.506457144855;5192.506711862367;5373.919391209135;5378.704171270579;5403.567714582824;5406;3624.220792529619;3628.2380700053022;3697.6856967157823;3698.7410881238325;3717.3494638438165;1080.778440419712;1084.9891501085046;1085.6905781852133;1096.1395304685784;1107.1530279336314;11527.942360288229;11615.303081815033;11693.941530292293;11720.941395293054;11746.823797643128;4545.772711364419;4640.2807564826835;4840.75796210188;4846.297286893451;4854.077725232265;9863.210943124534;9956.103950644332;9959.651412200683;9970.40177589347;9971.700848974397;5337.226102215157;5365.839024829262;5372.409035006146;5391.703456309862;5396.271503347077;4418.138462999748;4761.857144285677;4868.2210846264425;4922.384701912261;4929.137400954819;3883.76697398157;3930.4300876372768;4018.7588744675413;4074.144429669743;4078.938815917764;1270.4092596942467;1274.949002039908;1275.1902541885784;1285.5821857896035;1292.424870932445;779.5439667794403;859.441363113981;874.1477059866706;901.9413738107002;906.5648488725449;5828.358880523139;5880.558958078162;5937.0203916354185;6057.3336932937345;6211.223597050369;430.99784501077295;433.9804708788112;441.63785695729194;454.1167429349949;454.7953420960581;3969.54350249725;3976.980115099464;4066.2070896175555;4110.609492098246;4121.196366708523;10455.961087587999;10574.101201397814;10667.306625069346;10694;10728.678139655824;10645.0951669109;10646.254762166574;10647.94676026615;10649.361038337725;10661.84007239892;6385.553011289165;8168.754937351889;8183.140770219041;8267;8273.296769774517;5979.790707325223;6055.333913269449;6085.269767627913;6165.475934545614;6217.253929528486;9758.219342452445;9905.356151850106;9985.500724963578;10056.899431005597;10123.392596444237;8052.396070294869;8269.95865020671;10255.282130250811;10269.075783179549;10410.583576656849;7032.472564557576;7635.42734294919;7654.846903061796;7676.692932282646;7692.230776922263;7790.454668173174;8335.624896879775;8373.706920257762;8387.454815436977;8427.5786210688;7278.417726581755;7370.6683199255085;7451.515651482637;7535.585542795199;7642.4650274480255;7200.351968322876;7364.852702946018;7398.778036658909;7485;7486;6911.723531058701;7024.4029257513685;7052.471064670068;7059.682314295766;7071.893921591078;4968.527989841104;4995.275685025724;5042.697438153576;5111.718855462986;5125.231215317732;4969.428515720739;4999.200127979506;5154.716490593053;5202.869928251824;5209.973950130225 20:12:26 INFO - PROCESS | 2214 | |4;prototype.html;296.3376852734139;302.4253917556643;309.1390477520107;310.1038000179481;312.0482528288719;5361.7587208575615;5458.208559758833;5497.587680923932;5635.380108188101;5640.802571909984;5045.234168041184;5157.200633901742;5443.428440013801;5561.5828812839;5569.582281328896;3541.7874927504304;3711.740178187528;4217.536071032199;4284.143171365739;4289.828406863721;3401.489776533515;3889.630485103925;4220.198162349159;4305.526392096883;4320.638998715394;3601.56781186258;4053.777042262689;4149.97925010376;4203.4325366075645;4204.2432362174795;3430.5540279763723;4190.706650534479;4206.684498662582;4244.681648876316;4246.596573325529;3626.2384899171207;3627.963720362789;3637.909052273688;3640.8179591020607;3643.43526753351;5297.258383826267;5383.380911195184;5430.42980487051;5441.782328706847;5455.8363249102595;3986.388915260509;4201.831926722927;4409.713368631061;4644.164050470914;4826.541478559531;4626.583607475343;5066.82266120684;5382.730863456812;5877.706114694291;5914.467697907209;3051.359214564944;3637.3270944875285;3762.1535154590274;3918.647321741057;3959.208158368338;5671.432856714337;5737.164107485606;5906.291245050578;6151.815445536641;6242.972158503122;3400.897973060812;3523.224890524081;4002.599740025974;4025.255327764373;4035.4552135461336;3765.736398452082;3981.1838573092446;4074.4499492568716;4074.8777536673947;4076.429299898017;4741.767140543415;4749.24012158053;4804.231322988375;4811.855644330676;4824.215040435061;5362.383325917492;5421.864453388697;5646.6047376684055;5926.496247818984;6000.939990600038;1241.6647505173553;1368.842583102936;1378.9241591712553;1385.8267716535433;1392.436063394327;818.9918100819035;865.4417900454172;881.5988725130051;931.1712575807537;933.5892207428709;4644.744539050317;5063.797448102108;5100.903305789273;5421.972890135524;5468.648481153143;5444.50999410055;5538.861528461821;6034.978282275487;6038.698065096728;6072.726727297194;4858.927116093261;5202.505761952609;5312.3890752563175;5490.835274941758;5495.697736624524;2821.730221400378;2880.337522369825;2972.346083861547;3270.378628060661;3273.1326198556926;5759.452851979056;5859.677717725566;6394.776182833579;6441.774537891245;6485.513586481033;5522.779088836482;5539.725863051521;6333.841653958596;6355.3009168991375;6362.395572420613;5546.833594992157;5635.492805647429;5836.533077353802;6368.853606350716;6469.762305689781;4686.882827929193;5607.859803504782;5635.6323849017335;5734.738357561329;6118.552578968271;5014.373203349582;6038.849028774316;6050.969745151246;6128.8774224516155;6164.352742961924;6045.848853778691;6124.775044990931;6238.906416403848;6414.75483580743;6536.705848236746;3331.0839519131464;3714.9226724249665;3971.980140099281;4004.739691920016;4029.456023436916;4607.838725644587;5618.915716264178;6181.856356574048;6194.81415557534;6219.662772503933;5801.883962320646;5905.40945905406;5942.7920022799;5994.580379373402;6006.789762358297;4771.4512831023485;5633.577561648367;6015.4586087252355;6039.305479869696;6047.818565443044;5519.123498010696;5555.749991250323;5750;5770.451807078321;5829.271341082364;5620.662760234399;5948.672822994777;5992.561785171614;6016.548758843017;6050.515958723204;4997;5399.352077750695;5474.452554744494;5761.55134068011;5869.3859188723445 20:12:26 INFO - PROCESS | 2214 | |5;yui.html;591.9312004544119;719.4244604316546;732.1616748822602;764.5374548398219;812.1229072601589;15188.696226075486;15978.041317520956;16140.354385824583;16151.515454536353;16835.41076062338;15857.762133567976;16084.678306433865;16406.589835254093;16490;16516.174191290447;833.9617176615122;856.1010938514565;858.5578427110044;858.7938894665298;859.1966511311912;660.2308310817891;830.7923019245188;853.0616322045731;854.239726643288;860.7977125375531;896.4710820615835;898.290350623007;899.7660608241839;901.6708901251029;905.0768216419249;881.8721285413579;894.5214310343999;895.5969813583881;897.7082448204294;899.4423457456386;655.7540922154192;666.4901350466897;667.4126768443787;668.478586702368;668.7893313606247;13942.67544583263;15196.316165772567;15208.771868421982;15321.846781532153;15327.386904523806;11474.909883561048;12280;12547.623571292876;12552.560660376934;14383.856161438356;10961.83450288893;11413.771724565546;11447.370394628291;11473.885261147365;11593.420328983602;3814.893680832555;3832.6933845292588;3844.6347596978244;3856.84572617095;3987.5613682494904;115121;116462;117351.41324293324;120906.18640720485;121041.39479302547;9055.728328150166;10763.946180269206;10910.509027093642;11083.944580277048;11308.943455282671;18073.909630452028;22208.11167553312;22263.109475620793;22305.776942230368;22360.664590031163;7660.885086723703;7999.480033797785;8039.236272554098;8215.260626543639;8286.337093032544;4470.798814053375;4472.08322293929;4476.686631935799;4485.0805584855025;4496.662750293741;3586.6951309139017;3695.6489133532273;3734.1598140418732;3757.455169000534;3761.360568703327;603.432773193197;675.5136301862651;686.4508393285352;693.8987323004009;699.9055127557816;530.3132443485619;591.204829504316;643.8744444833212;673.2426020726682;675.76010516267;7767.689292428353;8501.787455313666;9684.854727179098;9711.5144242789;9893.356931799553;558.6396774080695;587.9941200588025;680.5424469723391;684.7877158081011;695.422799076765;3624.571537070169;4529.68292219548;4767.750563906011;4776.8566942991765;4781.737004464788;159521.40478595297;160739;161444;163747;164331.1783441099;135400;135598;137413;138724;140233.43291285078;86034;95361.5231923836;100147.4977875347;110217.44891275492;122060;9375.046860239003;9640.71077867665;9829.480447457843;10028.22397992965;10125.89874101279;47180.52819471761;48078.75960620175;56965.71517142554;60127.098093527755;65523.80952380953;97987;99824.50087749514;101336.98663013276;101452;101752.80719120742;10935.617253396093;12499.93750031244;13008;13120.212787232414;13724.794128087888;14709.55871323862;14720.337584808924;14766.852331476548;15009.924950375615;15118.900625371993;11656.708582285171;12878.613641590768;13818.792718109034;13911.721765564429;14198.716025679636;12081.973032292353;12446.25322480654;12621.558245461365;13947.860521394656;14529.200893950934;12605.68485787826;13726.89042291491;13767.724645506833;13797.862021379658;14065.648358791112;11155.83266251023;11243.212975091992;11291.3789741565;11297.345123895713;11582.204758262145;8751.387402881737;11256;11384.089272858317;11588.94205528967;11615.36115513621 20:12:26 INFO - PROCESS | 2214 | __end_tp_report 20:12:26 INFO - PROCESS | 2214 | __start_cc_report 20:12:26 INFO - PROCESS | 2214 | _x_x_mozilla_cycle_collect,376 20:12:26 INFO - PROCESS | 2214 | __end_cc_report 20:12:26 INFO - PROCESS | 2214 | __startTimestamp1472267546497__endTimestamp 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | ------- Summary: start ------- 20:12:26 INFO - PROCESS | 2214 | Number of tests: 6 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | [#0] dojo.html Cycles:165 Average:5719.48 Median:6002.85 stddev:676.16 (11.3%) stddev-sans-first:653.61 20:12:26 INFO - PROCESS | 2214 | Values: 3414.3 3414.5 3415.8 3421.3 3462.5 5532.9 5789.1 5844.8 5852.5 5930.6 4767.6 5193.3 5765.7 5780.1 5797.1 5164.9 5257.5 5301.3 5334.8 5364.3 5231.8 5269.1 5300.4 5368.9 5380.4 5219.5 5259.9 5266.0 5291.4 5319.1 5318.2 5338.3 5342.9 5343.7 5414.1 5233.6 5244.3 5262.5 5266.6 5322.0 5723.1 5863.8 5864.3 5865.1 5890.2 6189.5 6225.0 6241.6 6258.2 6265.3 6154.8 6180.7 6184.4 6206.8 6228.8 5935.5 5955.8 5958.9 5959.1 6002.8 5452.7 6423.9 6431.3 6454.2 6496.0 6121.7 6125.5 6145.9 6181.5 6196.6 6282.7 6284.4 6291.7 6299.7 6312.5 6099.2 6225.1 6234.0 6252.1 6252.5 6096.7 6154.8 6163.8 6203.7 6216.7 4308.8 4994.5 5003.4 5007.7 5069.2 4440.3 4452.7 4460.4 4472.0 4493.4 4718.3 5053.8 5340.4 5999.8 6002.6 4739.5 5387.6 6042.0 6081.3 6304.2 4383.0 4685.5 4736.9 5978.4 6051.2 5086.6 5372.9 5453.3 5482.5 5505.8 5688.1 6453.2 6454.4 6469.5 6497.3 5232.2 5943.4 6192.2 6242.0 6264.2 6236.3 6363.1 6416.4 6420.7 6456.3 6178.0 6232.9 6248.3 6254.1 6259.0 6253.4 6254.5 6268.2 6277.2 6298.7 5016.8 6027.2 6069.2 6099.3 6214.6 6146.9 6156.6 6159.8 6167.4 6207.9 4957.4 5924.6 6028.8 6094.7 6113.9 6092.5 6114.3 6118.5 6139.3 6148.3 6019.2 6079.4 6088.5 6099.5 6118.1 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | [#1] ext.html Cycles:180 Average:62706.61 Median:39001.01 stddev:137693.26 (353.1%) stddev-sans-first:138000.25 20:12:26 INFO - PROCESS | 2214 | Values: 478.0 489.8 494.6 524.3 526.9 28815.0 36757.0 40574.0 40580.0 40592.2 41173.4 41676.4 41690.6 41844.6 41871.0 9593.1 9764.7 9798.8 9803.3 9854.4 9687.8 9759.0 9770.4 9778.4 9794.6 9762.0 9778.7 9791.8 9793.9 9807.0 9721.0 9737.6 9750.8 9751.2 9759.6 9612.8 9694.6 9721.9 9722.0 9723.4 32377.0 38570.2 39077.6 39285.8 39434.0 2911.8 3566.5 3567.3 3854.8 3961.2 30731.8 30998.5 31174.8 31285.2 32218.0 3244.0 3292.2 3296.3 3359.6 3404.2 286729.0 341562.0 347384.0 347895.0 348015.3 33214.0 59867.4 60192.7 60194.7 60317.0 34070.8 34632.8 34979.0 35194.8 35221.6 14276.5 14453.4 14548.9 14607.3 14633.3 9724.7 10868.3 11218.9 11402.0 12294.3 6534.8 6571.6 6746.3 7700.5 7857.5 3181.3 3234.2 3236.7 3246.3 3272.1 849.8 875.7 910.5 970.4 1044.4 28070.4 28258.2 30340.8 30411.2 30430.2 1047.1 1078.2 1139.5 1139.9 1170.4 12938.7 15457.6 15639.3 15901.8 15938.2 586010.0 642602.0 643365.0 649054.0 650955.0 55174.4 56253.7 56308.7 56391.2 56482.4 1324.6 1358.3 1371.2 1371.9 1379.3 25363.1 27323.3 27666.0 28748.6 29724.6 50189.2 50753.2 50795.0 50805.7 50809.7 462534.0 533036.0 541901.0 543163.0 546883.0 26558.6 27088.6 27101.8 27115.2 27162.2 46761.0 46786.8 47098.0 48176.8 48344.0 38796.3 38866.4 38924.4 39732.6 40905.8 38470.6 38570.8 39424.0 39505.6 40022.8 37950.4 38026.4 39212.8 39721.8 40299.4 30463.8 31111.9 34553.8 34852.5 34909.7 24330.5 25463.2 25487.4 25988.4 26184.6 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | [#2] jquery.html Cycles:180 Average:33854.33 Median:2084.10 stddev:93663.86 (4494.2%) stddev-sans-first:93892.86 20:12:26 INFO - PROCESS | 2214 | Values: 365.6 367.4 373.1 375.8 394.0 19441.6 20290.0 20890.7 21114.4 21238.9 11186.4 11215.5 11897.9 11904.9 11924.5 5285.4 5506.4 5541.5 5554.2 5559.5 3910.9 5390.2 5839.5 6103.7 6159.4 5000.8 5230.3 6114.7 6169.1 6179.0 4563.8 5107.9 5376.2 6154.8 6162.0 4738.2 5032.9 5917.2 6016.2 6023.5 11908.9 12085.0 12226.0 12232.8 12253.2 2027.4 2079.8 2088.4 2169.5 2919.4 9805.7 10326.0 10370.5 15309.5 15462.7 1704.7 1837.8 1857.6 1876.4 1889.4 117992.0 120357.0 126137.0 133773.3 135154.0 11206.8 11276.2 11294.3 11387.7 11507.5 14309.5 14433.0 14455.0 14474.1 14498.9 8316.8 8339.3 8475.5 8501.1 8610.7 7430.8 8273.8 8418.5 8438.7 8582.9 3515.6 4471.6 4490.8 4500.9 4519.9 1549.9 1628.2 1653.5 1887.3 1931.3 745.4 907.7 923.4 936.3 995.6 15333.5 19891.0 20415.4 20774.6 20785.0 893.5 944.7 947.0 950.9 963.5 8784.6 10458.6 10673.5 10902.5 10937.9 474929.0 562365.0 566433.0 577166.0 585355.0 132211.3 133175.0 135696.0 138071.0 138291.0 904.4 943.5 957.6 959.9 967.9 10859.0 11316.4 17906.9 17962.6 18825.6 53320.0 54805.5 55489.0 58195.5 58896.0 81256.0 81997.2 82089.0 82811.6 84895.6 12620.1 12644.2 12839.9 13000.0 13035.9 13912.4 13951.5 14109.4 14263.0 14427.9 11553.0 11713.6 12028.8 12053.1 12162.0 9935.4 10330.4 10471.3 11430.1 11879.0 4705.9 4707.8 6689.8 7979.8 8215.6 10114.5 10563.9 11853.6 12114.8 12261.0 11625.6 11674.3 11802.6 12015.2 12035.9 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | [#3] mootools.html Cycles:180 Average:5699.43 Median:4968.98 stddev:3180.01 (64.0%) stddev-sans-first:3173.13 20:12:26 INFO - PROCESS | 2214 | Values: 1481.1 1507.9 1534.9 1740.3 1793.2 7745.5 7881.6 8383.0 8562.9 8747.9 8611.2 8810.7 8817.4 8837.2 8847.2 2352.9 2371.5 2383.2 2390.3 2397.0 2365.8 2378.6 2409.1 2412.8 2417.0 2376.8 2383.7 2384.3 2394.0 2394.9 2345.3 2347.5 2365.5 2371.2 2380.8 2327.8 2358.8 2360.8 2362.2 2366.0 8876.0 8896.2 8956.4 8964.0 8973.5 5192.5 5373.9 5378.7 5403.6 5406.0 3624.2 3628.2 3697.7 3698.7 3717.3 1080.8 1085.0 1085.7 1096.1 1107.2 11527.9 11615.3 11693.9 11720.9 11746.8 4545.8 4640.3 4840.8 4846.3 4854.1 9863.2 9956.1 9959.7 9970.4 9971.7 5337.2 5365.8 5372.4 5391.7 5396.3 4418.1 4761.9 4868.2 4922.4 4929.1 3883.8 3930.4 4018.8 4074.1 4078.9 1270.4 1274.9 1275.2 1285.6 1292.4 779.5 859.4 874.1 901.9 906.6 5828.4 5880.6 5937.0 6057.3 6211.2 431.0 434.0 441.6 454.1 454.8 3969.5 3977.0 4066.2 4110.6 4121.2 10456.0 10574.1 10667.3 10694.0 10728.7 10645.1 10646.3 10647.9 10649.4 10661.8 6385.6 8168.8 8183.1 8267.0 8273.3 5979.8 6055.3 6085.3 6165.5 6217.3 9758.2 9905.4 9985.5 10056.9 10123.4 8052.4 8270.0 10255.3 10269.1 10410.6 7032.5 7635.4 7654.8 7676.7 7692.2 7790.5 8335.6 8373.7 8387.5 8427.6 7278.4 7370.7 7451.5 7535.6 7642.5 7200.4 7364.9 7398.8 7485.0 7486.0 6911.7 7024.4 7052.5 7059.7 7071.9 4968.5 4995.3 5042.7 5111.7 5125.2 4969.4 4999.2 5154.7 5202.9 5210.0 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | [#4] prototype.html Cycles:180 Average:4714.87 Median:5410.61 stddev:1497.09 (27.7%) stddev-sans-first:1464.10 20:12:26 INFO - PROCESS | 2214 | Values: 296.3 302.4 309.1 310.1 312.0 5361.8 5458.2 5497.6 5635.4 5640.8 5045.2 5157.2 5443.4 5561.6 5569.6 3541.8 3711.7 4217.5 4284.1 4289.8 3401.5 3889.6 4220.2 4305.5 4320.6 3601.6 4053.8 4150.0 4203.4 4204.2 3430.6 4190.7 4206.7 4244.7 4246.6 3626.2 3628.0 3637.9 3640.8 3643.4 5297.3 5383.4 5430.4 5441.8 5455.8 3986.4 4201.8 4409.7 4644.2 4826.5 4626.6 5066.8 5382.7 5877.7 5914.5 3051.4 3637.3 3762.2 3918.6 3959.2 5671.4 5737.2 5906.3 6151.8 6243.0 3400.9 3523.2 4002.6 4025.3 4035.5 3765.7 3981.2 4074.4 4074.9 4076.4 4741.8 4749.2 4804.2 4811.9 4824.2 5362.4 5421.9 5646.6 5926.5 6000.9 1241.7 1368.8 1378.9 1385.8 1392.4 819.0 865.4 881.6 931.2 933.6 4644.7 5063.8 5100.9 5422.0 5468.6 5444.5 5538.9 6035.0 6038.7 6072.7 4858.9 5202.5 5312.4 5490.8 5495.7 2821.7 2880.3 2972.3 3270.4 3273.1 5759.5 5859.7 6394.8 6441.8 6485.5 5522.8 5539.7 6333.8 6355.3 6362.4 5546.8 5635.5 5836.5 6368.9 6469.8 4686.9 5607.9 5635.6 5734.7 6118.6 5014.4 6038.8 6051.0 6128.9 6164.4 6045.8 6124.8 6238.9 6414.8 6536.7 3331.1 3714.9 3972.0 4004.7 4029.5 4607.8 5618.9 6181.9 6194.8 6219.7 5801.9 5905.4 5942.8 5994.6 6006.8 4771.5 5633.6 6015.5 6039.3 6047.8 5519.1 5555.7 5750.0 5770.5 5829.3 5620.7 5948.7 5992.6 6016.5 6050.5 4997.0 5399.4 5474.5 5761.6 5869.4 20:12:26 INFO - PROCESS | 2214 | 20:12:26 INFO - PROCESS | 2214 | [#5] yui.html Cycles:180 Average:25552.59 Median:12973.68 stddev:41833.11 (322.4%) stddev-sans-first:41908.49 20:12:26 INFO - PROCESS | 2214 | Values: 591.9 719.4 732.2 764.5 812.1 15188.7 15978.0 16140.4 16151.5 16835.4 15857.8 16084.7 16406.6 16490.0 16516.2 834.0 856.1 858.6 858.8 859.2 660.2 830.8 853.1 854.2 860.8 896.5 898.3 899.8 901.7 905.1 881.9 894.5 895.6 897.7 899.4 655.8 666.5 667.4 668.5 668.8 13942.7 15196.3 15208.8 15321.8 15327.4 11474.9 12280.0 12547.6 12552.6 14383.9 10961.8 11413.8 11447.4 11473.9 11593.4 3814.9 3832.7 3844.6 3856.8 3987.6 115121.0 116462.0 117351.4 120906.2 121041.4 9055.7 10763.9 10910.5 11083.9 11308.9 18073.9 22208.1 22263.1 22305.8 22360.7 7660.9 7999.5 8039.2 8215.3 8286.3 4470.8 4472.1 4476.7 4485.1 4496.7 3586.7 3695.6 3734.2 3757.5 3761.4 603.4 675.5 686.5 693.9 699.9 530.3 591.2 643.9 673.2 675.8 7767.7 8501.8 9684.9 9711.5 9893.4 558.6 588.0 680.5 684.8 695.4 3624.6 4529.7 4767.8 4776.9 4781.7 159521.4 160739.0 161444.0 163747.0 164331.2 135400.0 135598.0 137413.0 138724.0 140233.4 86034.0 95361.5 100147.5 110217.4 122060.0 9375.0 9640.7 9829.5 10028.2 10125.9 47180.5 48078.8 56965.7 60127.1 65523.8 97987.0 99824.5 101337.0 101452.0 101752.8 10935.6 12499.9 13008.0 13120.2 13724.8 14709.6 14720.3 14766.9 15009.9 15118.9 11656.7 12878.6 13818.8 13911.7 14198.7 12082.0 12446.3 12621.6 13947.9 14529.2 12605.7 13726.9 13767.7 13797.9 14065.6 11155.8 11243.2 11291.4 11297.3 11582.2 8751.4 11256.0 11384.1 11588.9 11615.4 20:12:26 INFO - PROCESS | 2214 | -------- Summary: end -------- 20:12:26 INFO - PROCESS | 2214 | 20:12:27 INFO - TEST-INFO | 2214: exit 0 20:12:27 INFO - TEST-OK | dromaeo_css | took 1114223ms 20:12:27 INFO - TEST-START | kraken 20:12:27 INFO - operating with platform_type : mac_ 20:12:27 INFO - Initialising browser for kraken test... 20:12:27 INFO - TEST-INFO | started process 2219 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmp3ThKBZ/profile http://localhost:64069/getInfo.html) 20:12:29 INFO - PROCESS | 2219 | __metrics Screen width/height:1600/1200 20:12:29 INFO - PROCESS | 2219 | colorDepth:24 20:12:29 INFO - PROCESS | 2219 | Browser inner width/height: 1024/689 20:12:29 INFO - PROCESS | 2219 | __metrics 20:12:29 ERROR - PROCESS | 2219 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 20:12:30 INFO - TEST-INFO | 2219: exit 0 20:12:30 INFO - Browser initialized. 20:12:30 INFO - Running cycle 1/1 for kraken test... 20:12:30 INFO - TEST-INFO | started process 2221 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmp3ThKBZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:42 INFO - PROCESS | 2221 | RSS: Main: 243544064 20:12:42 INFO - PROCESS | 2221 | 20:12:45 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64069/tests/kraken/driver.html?testName=audio-beat-detection) 20:12:46 INFO - PROCESS | 2221 | RSS: Main: 256413696 20:12:46 INFO - PROCESS | 2221 | 20:12:49 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64069/tests/kraken/driver.html?testName=audio-dft) 20:12:49 INFO - PROCESS | 2221 | RSS: Main: 265027584 20:12:49 INFO - PROCESS | 2221 | 20:12:53 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64069/tests/kraken/driver.html?testName=audio-fft) 20:12:53 INFO - PROCESS | 2221 | RSS: Main: 261795840 20:12:53 INFO - PROCESS | 2221 | 20:12:55 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64069/tests/kraken/driver.html?testName=audio-oscillator) 20:12:56 INFO - PROCESS | 2221 | RSS: Main: 264069120 20:12:56 INFO - PROCESS | 2221 | 20:12:58 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64069/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:12:59 INFO - PROCESS | 2221 | RSS: Main: 264454144 20:12:59 INFO - PROCESS | 2221 | 20:13:01 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64069/tests/kraken/driver.html?testName=imaging-darkroom) 20:13:02 INFO - PROCESS | 2221 | RSS: Main: 264777728 20:13:02 INFO - PROCESS | 2221 | 20:13:05 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64069/tests/kraken/driver.html?testName=imaging-desaturate) 20:13:06 INFO - PROCESS | 2221 | RSS: Main: 266117120 20:13:06 INFO - PROCESS | 2221 | 20:13:09 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64069/tests/kraken/driver.html?testName=json-parse-financial) 20:13:10 INFO - PROCESS | 2221 | RSS: Main: 265936896 20:13:10 INFO - PROCESS | 2221 | 20:13:11 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64069/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:13:12 INFO - PROCESS | 2221 | RSS: Main: 265945088 20:13:12 INFO - PROCESS | 2221 | 20:13:14 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:13:14 INFO - PROCESS | 2221 | RSS: Main: 266010624 20:13:14 INFO - PROCESS | 2221 | 20:13:16 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:13:17 INFO - PROCESS | 2221 | RSS: Main: 266432512 20:13:17 INFO - PROCESS | 2221 | 20:13:20 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:13:21 INFO - PROCESS | 2221 | RSS: Main: 266559488 20:13:21 INFO - PROCESS | 2221 | 20:13:24 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:13:25 INFO - PROCESS | 2221 | RSS: Main: 266383360 20:13:25 INFO - PROCESS | 2221 | 20:13:26 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:64069/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64069/tests/kraken/driver.html?testName=ai-astar) 20:13:27 INFO - PROCESS | 2221 | RSS: Main: 268328960 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | __start_tp_report 20:13:27 INFO - PROCESS | 2221 | _x_x_mozilla_page_load 20:13:27 INFO - PROCESS | 2221 | _x_x_mozilla_page_load_details 20:13:27 INFO - PROCESS | 2221 | |i|pagename|runs| 20:13:27 INFO - PROCESS | 2221 | |0;ai-astar;111;117;117;116;117;116;98;176;111;193 20:13:27 INFO - PROCESS | 2221 | |1;audio-beat-detection;148;111;136;158;119;129;128;146;205;134 20:13:27 INFO - PROCESS | 2221 | |2;audio-dft;193;202;229;199;201;236;276;197;189;189 20:13:27 INFO - PROCESS | 2221 | |3;audio-fft;73;86;96;184;52;60;83;89;163;51 20:13:27 INFO - PROCESS | 2221 | |4;audio-oscillator;72;74;126;69;70;83;113;68;72;112 20:13:27 INFO - PROCESS | 2221 | |5;imaging-gaussian-blur;92;107;136;89;90;101;92;87;93;88 20:13:27 INFO - PROCESS | 2221 | |6;imaging-darkroom;127;92;154;152;105;153;97;154;153;115 20:13:27 INFO - PROCESS | 2221 | |7;imaging-desaturate;92;95;110;90;93;92;90;92;92;90 20:13:27 INFO - PROCESS | 2221 | |8;json-parse-financial;57;59;56;58;58;58;57;57;58;57 20:13:27 INFO - PROCESS | 2221 | |9;json-stringify-tinderbox;66;72;77;70;81;81;80;74;82;85 20:13:27 INFO - PROCESS | 2221 | |10;stanford-crypto-aes;90;90;87;86;86;90;90;90;92;91 20:13:27 INFO - PROCESS | 2221 | |11;stanford-crypto-ccm;131;159;161;131;179;165;166;159;198;159 20:13:27 INFO - PROCESS | 2221 | |12;stanford-crypto-pbkdf2;173;173;176;173;174;171;156;216;216;176 20:13:27 INFO - PROCESS | 2221 | |13;stanford-crypto-sha256-iterative;68;87;75;68;69;62;67;89;100;79 20:13:27 INFO - PROCESS | 2221 | __end_tp_report 20:13:27 INFO - PROCESS | 2221 | __start_cc_report 20:13:27 INFO - PROCESS | 2221 | _x_x_mozilla_cycle_collect,977 20:13:27 INFO - PROCESS | 2221 | __end_cc_report 20:13:27 INFO - PROCESS | 2221 | __startTimestamp1472267607071__endTimestamp 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | ------- Summary: start ------- 20:13:27 INFO - PROCESS | 2221 | Number of tests: 14 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#0] ai-astar Cycles:10 Average:127.20 Median:117.00 stddev:31.00 (26.5%) stddev-sans-first:32.33 20:13:27 INFO - PROCESS | 2221 | Values: 111.0 117.0 117.0 116.0 117.0 116.0 98.0 176.0 111.0 193.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:141.00 stddev:26.31 (18.7%) stddev-sans-first:27.79 20:13:27 INFO - PROCESS | 2221 | Values: 148.0 111.0 136.0 158.0 119.0 129.0 128.0 146.0 205.0 134.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#2] audio-dft Cycles:10 Average:211.10 Median:201.50 stddev:27.86 (13.8%) stddev-sans-first:28.77 20:13:27 INFO - PROCESS | 2221 | Values: 193.0 202.0 229.0 199.0 201.0 236.0 276.0 197.0 189.0 189.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#3] audio-fft Cycles:10 Average:93.70 Median:78.00 stddev:45.07 (57.8%) stddev-sans-first:47.18 20:13:27 INFO - PROCESS | 2221 | Values: 73.0 86.0 96.0 184.0 52.0 60.0 83.0 89.0 163.0 51.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:71.00 stddev:22.16 (31.2%) stddev-sans-first:22.92 20:13:27 INFO - PROCESS | 2221 | Values: 72.0 74.0 126.0 69.0 70.0 83.0 113.0 68.0 72.0 112.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:89.50 stddev:14.89 (16.6%) stddev-sans-first:15.66 20:13:27 INFO - PROCESS | 2221 | Values: 92.0 107.0 136.0 89.0 90.0 101.0 92.0 87.0 93.0 88.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#6] imaging-darkroom Cycles:10 Average:130.20 Median:153.50 stddev:26.00 (16.9%) stddev-sans-first:27.55 20:13:27 INFO - PROCESS | 2221 | Values: 127.0 92.0 154.0 152.0 105.0 153.0 97.0 154.0 153.0 115.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:92.00 stddev:5.97 (6.5%) stddev-sans-first:6.30 20:13:27 INFO - PROCESS | 2221 | Values: 92.0 95.0 110.0 90.0 93.0 92.0 90.0 92.0 92.0 90.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 20:13:27 INFO - PROCESS | 2221 | Values: 57.0 59.0 56.0 58.0 58.0 58.0 57.0 57.0 58.0 57.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#9] json-stringify-tinderbox Cycles:10 Average:76.80 Median:80.50 stddev:6.09 (7.6%) stddev-sans-first:5.05 20:13:27 INFO - PROCESS | 2221 | Values: 66.0 72.0 77.0 70.0 81.0 81.0 80.0 74.0 82.0 85.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:90.00 stddev:2.10 (2.3%) stddev-sans-first:2.20 20:13:27 INFO - PROCESS | 2221 | Values: 90.0 90.0 87.0 86.0 86.0 90.0 90.0 90.0 92.0 91.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:163.00 stddev:19.85 (12.2%) stddev-sans-first:17.88 20:13:27 INFO - PROCESS | 2221 | Values: 131.0 159.0 161.0 131.0 179.0 165.0 166.0 159.0 198.0 159.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:175.00 stddev:19.61 (11.2%) stddev-sans-first:20.62 20:13:27 INFO - PROCESS | 2221 | Values: 173.0 173.0 176.0 173.0 174.0 171.0 156.0 216.0 216.0 176.0 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - PROCESS | 2221 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:72.00 stddev:12.15 (16.9%) stddev-sans-first:12.50 20:13:27 INFO - PROCESS | 2221 | Values: 68.0 87.0 75.0 68.0 69.0 62.0 67.0 89.0 100.0 79.0 20:13:27 INFO - PROCESS | 2221 | -------- Summary: end -------- 20:13:27 INFO - PROCESS | 2221 | 20:13:27 INFO - TEST-INFO | 2221: exit 0 20:13:27 INFO - TEST-OK | kraken | took 60722ms 20:13:27 INFO - SUITE-END | took 1174s 20:13:28 INFO - Completed test suite (00:19:35) 20:13:28 INFO - javascript benchmark 20:13:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7233.496427507728, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3414.28300056988, 3414.4707570326577, 3415.8292085395733, 3421.3328400961823, 3462.5152478652994, 5532.944670553294, 5789.102689083194, 5844.7662093516265, 5852.473277405033, 5930.555208359379, 4767.6424268179935, 5193.324867767185, 5765.740541675635, 5780.132980052994, 5797.130430435426, 5164.922526162101, 5257.474252574751, 5301.3373328333955, 5334.786608535654, 5364.302640656709, 5231.790728370861, 5269.130593452076, 5300.363956325227, 5368.892622147555, 5380.414453504893, 5219.504147106038, 5259.947400525984, 5265.97313523863, 5291.417944026154, 5319.148936170213, 5318.202269659543, 5338.332708411449, 5342.866428339284, 5343.706096164709, 5414.10667239905, 5233.607479439019, 5244.292020577212, 5262.500062494095, 5266.578673706133, 5321.988822123784, 5723.141528770676, 5863.76544938202, 5864.325602555718, 5865.120231965197, 5890.175375447441, 6189.535784816157, 6225.035119556476, 6241.594296370721, 6258.217722784652, 6265.310815810257, 6154.799814036265, 6180.690965451754, 6184.350643182446, 6206.782762603332, 6228.781992630282, 5935.465808077293, 5955.821325360246, 5958.851028724316, 5959.10613407988, 6002.8499287517725, 5452.672839629635, 6423.857198987367, 6431.260405053479, 6454.160959075384, 6496.0, 6121.724522396503, 6125.47964319526, 6145.907811382833, 6181.505479561624, 6196.628202307876, 6282.654454004982, 6284.402981716729, 6291.748330066837, 6299.6535190564955, 6312.495000399957, 6099.237595300588, 6225.066240063936, 6233.96883015582, 6252.062190671436, 6252.468540174045, 6096.7081148910665, 6154.78458253959, 6163.8150855474405, 6203.689815509297, 6216.689165541705, 4308.827646894152, 4994.525520075587, 5003.399592048904, 5007.7245751484015, 5069.188929771219, 4440.311751678495, 4452.688311818207, 4460.420145381079, 4471.977640111843, 4493.370928070073, 4718.3158442025715, 5053.787091098184, 5340.359156901119, 5999.820005399845, 6002.579819412599, 4739.502352253033, 5387.595930305164, 6041.969790151021, 6081.331053584102, 6304.180456540712, 4382.99191186029, 4685.461171965199, 4736.8631528432925, 5978.372270911578, 6051.152838602599, 5086.618503612244, 5372.892542149135, 5453.318335208099, 5482.479164479368, 5505.779768809202, 5688.11834165705, 6453.1610890583925, 6454.386833250834, 6469.51478639104, 6497.252815926135, 5232.215167724719, 5943.435373639497, 6192.195014648067, 6242.035033359118, 6264.248290205204, 6236.314005459487, 6363.077353783768, 6416.358364163546, 6420.743170273324, 6456.2575303838785, 6178.042403427476, 6232.906506402317, 6248.250209974832, 6254.093156492374, 6259.029850373017, 6253.37466253371, 6254.499640028877, 6268.216472940882, 6277.2153480814895, 6298.71655775482, 5016.799328026838, 6027.21646185993, 6069.2110025696375, 6099.279518885317, 6214.5960512566535, 6146.907796383147, 6156.569040167325, 6159.81520554384, 6167.444929956326, 6207.875842483216, 4957.380327459067, 5924.555658325729, 6028.764103358889, 6094.695265236632, 6113.877722445615, 6092.482139018233, 6114.297368146176, 6118.4668989547035, 6139.338817383189, 6148.262208535004, 6019.247594050744, 6079.392060793885, 6088.4824789893355, 6099.542534309856, 6118.143459915705], "value": 5679.75943455737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.0415267388887, 489.7820469890899, 494.56231235356745, 524.3131497737963, 526.897255035268, 28814.991475298368, 36757.0, 40573.95695322852, 40579.985500362505, 40592.18815623686, 41173.38239926403, 41676.374854377136, 41690.58309416905, 41844.58155418445, 41871.0, 9593.136617704406, 9764.658236961708, 9798.755031124243, 9803.264755143357, 9854.40873547586, 9687.757806054835, 9759.0, 9770.413775173512, 9778.41329520231, 9794.608215671364, 9762.023797620252, 9778.653123250404, 9791.804163916753, 9793.902060979406, 9807.019298070207, 9721.0, 9737.56180971858, 9750.804983900352, 9751.17115045222, 9759.609615615438, 9612.807743845084, 9694.612215511372, 9721.854172187423, 9721.951390243074, 9723.416595004323, 32377.0, 38570.22859542821, 39077.609223907966, 39285.80357098225, 39434.0, 2911.781616378759, 3566.5185199998186, 3567.2687099144614, 3854.8458061677497, 3961.2473630010204, 30731.846340768378, 30998.535021974687, 31174.84412577945, 31285.217869553217, 32218.0, 3244.0, 3292.2427841596327, 3296.3407318536388, 3359.6136444308972, 3404.21703008307, 286729.0, 341562.0, 347384.0, 347895.0, 348015.2599237013, 33214.0, 59867.401325987055, 60192.699036505415, 60194.69902650459, 60317.0, 34070.80752173662, 34632.826835866166, 34979.0, 35194.76818311398, 35221.64778352235, 14276.500322488871, 14453.421863125357, 14548.854511454962, 14607.269636518131, 14633.317168525542, 9724.708258752107, 10868.293560918515, 11218.934201250868, 11402.030827379765, 12294.323812190236, 6534.836629084216, 6571.57284776488, 6746.347144949421, 7700.460967732317, 7857.528548287121, 3181.2683082890603, 3234.2399536108996, 3236.741060715184, 3246.302045060276, 3272.1001724525468, 849.8257857139272, 875.6935072724496, 910.4673765846921, 970.427447805798, 1044.4360045575456, 28070.43859122847, 28258.15225543237, 30340.84829575838, 30411.2397190072, 30430.239244019078, 1047.1413440978324, 1078.1751959750798, 1139.5327915554583, 1139.9487023083982, 1170.3563040327786, 12938.741225175443, 15457.613559660873, 15639.296231669603, 15901.800522379788, 15938.203089845461, 586010.0, 642602.0, 643364.9644524932, 649054.0, 650955.0, 55174.44825551773, 56253.71873140608, 56308.718456407456, 56391.15413268804, 56482.43517564772, 1324.602619214232, 1358.3479929633634, 1371.238962375871, 1371.945122195121, 1379.296558755022, 25363.112291069723, 27323.31691707723, 27666.0, 28748.568771468865, 29724.554131687608, 50189.24716129188, 50753.23870141877, 50795.0, 50805.745971269906, 50809.74595127001, 462534.0, 533036.0, 541901.0, 543163.0, 546883.0, 26558.601620976086, 27088.593671094553, 27101.780419881547, 27115.1865444037, 27162.185134445997, 46761.0, 46786.76606616945, 47098.0, 48176.7591162056, 48344.0, 38796.316106337035, 38866.41700374553, 38924.41613375745, 39732.60267397405, 40905.79547102245, 38470.615293846706, 38570.80714596409, 39424.0, 39505.604943950195, 40022.79988600155, 37950.43074353942, 38026.429603555414, 39212.803935981276, 39721.80139099286, 40299.395509067974, 30463.847680761453, 31111.911083111983, 34553.82723086469, 34852.47721284132, 34909.65090349165, 24330.51338973246, 25463.21757477033, 25487.36281592975, 25988.350291242114, 26184.607230891932], "value": 18238.494688869738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.6380183618217, 367.3919662957805, 373.1473582863158, 375.8064596732685, 394.03854594788714, 19441.611167776635, 20290.0, 20890.686639700416, 21114.366569002934, 21238.893805530988, 11186.384748838811, 11215.495302711377, 11897.940510297436, 11904.880951190486, 11924.523019079226, 5285.392179899303, 5506.421825708303, 5541.473560011793, 5554.166874968747, 5559.471850174227, 3910.902227444308, 5390.21841832934, 5839.474447299742, 6103.725332360033, 6159.353267906872, 5000.774965126559, 5230.34620672416, 6114.724837382306, 6169.136320915076, 6179.0, 4563.794629241692, 5107.90180111276, 5376.220448035033, 6154.846128846814, 6161.9691901540655, 4738.24188129901, 5032.924506132411, 5917.201177841022, 6016.157737916695, 6023.518118550505, 11908.940455297754, 12085.033197344192, 12226.0, 12232.755344893141, 12253.203541769757, 2027.432318950696, 2079.812816846491, 2088.385410182995, 2169.53355028668, 2919.3871485020786, 9805.656802011896, 10326.0, 10370.481475926174, 15309.464168754152, 15462.690746185126, 1704.6590681863677, 1837.7886543047453, 1857.609901920585, 1876.3807943378652, 1889.3576184097474, 117992.0, 120356.99999999913, 126137.0, 133773.33113334372, 135154.0, 11206.831897521544, 11276.1542884284, 11294.322340659586, 11387.658370248906, 11507.482163302671, 14309.499167529086, 14433.0, 14455.0, 14474.131552106906, 14498.927505362406, 8316.792080198044, 8339.291160251325, 8475.533845638425, 8501.14988501145, 8610.6986255482, 7430.848218526137, 8273.793155171168, 8418.48045639524, 8438.746837594881, 8582.914170858336, 3515.6308587598446, 4471.552844715502, 4490.820367185276, 4500.8649740507835, 4519.932201016987, 1549.8915075944576, 1628.1533602526856, 1653.4956838164476, 1887.339431199097, 1931.278267906532, 745.414849343263, 907.7140700679265, 923.4274749655123, 936.2930987104828, 995.5619527407918, 15333.463328783439, 19891.0, 20415.387538373874, 20774.58450830975, 20784.960751962342, 893.4862454088925, 944.7213072143734, 946.9715908522618, 950.8858936927613, 963.5182408795603, 8784.60469278884, 10458.63394781179, 10673.505709200717, 10902.454877256105, 10937.945310273397, 474929.0, 562365.0, 566433.0, 577166.0, 585355.0, 132211.33894330467, 133175.0, 135696.0, 138071.0, 138291.0, 904.4302089683457, 943.4575119306427, 957.6265256549951, 959.8704174936433, 967.8644989701447, 10859.0, 11316.37759923212, 17906.925584464974, 17962.5509362267, 18825.623487530447, 53320.0, 54805.45194548163, 55489.0, 58195.54511137086, 58896.0, 81256.0, 81997.21026502473, 82089.0, 82811.58594207231, 84895.57552212199, 12620.11659183885, 12644.178128421623, 12839.871601283867, 12999.960003199532, 13035.869641303465, 13912.443502259795, 13951.511697090553, 14109.365078571695, 14263.0, 14427.92786036063, 11553.0, 11713.590024349107, 12028.819567706667, 12053.096017798876, 12161.966232870305, 9935.403875767188, 10330.431826249629, 10471.3193642413, 11430.085593152695, 11879.0, 4705.905881882411, 4707.764611769329, 6689.8327541809895, 7979.800504987422, 8215.630296636546, 10114.544845481823, 10563.894361056598, 11853.5851245206, 12114.75770484603, 12261.01911847068, 11625.59310424131, 11674.299542027506, 11802.645920622395, 12015.158938874545, 12035.879641203475], "value": 9224.630343202864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.0669278354637, 1507.9095254284741, 1534.9462768803094, 1740.2603893345324, 1793.1751394358594, 7745.535267883924, 7881.605919704006, 8383.0, 8562.929633795775, 8747.91252087479, 8611.181937715923, 8810.691625793082, 8817.42686725364, 8837.204651581356, 8847.247983921374, 2352.8941197646104, 2371.490129622131, 2383.2254517281867, 2390.282915125464, 2396.9640455393182, 2365.775251351119, 2378.595638741418, 2409.0965887792077, 2412.8431651942656, 2416.996946267297, 2376.8217383696206, 2383.678203442539, 2384.308550520347, 2393.9521209575796, 2394.940126496834, 2345.2645042668473, 2347.542229265294, 2365.4677697518005, 2371.2174982255815, 2380.7619238076227, 2327.7788610082016, 2358.8112950964055, 2360.78752912237, 2362.161432691404, 2365.976340236593, 8876.0, 8896.199342059246, 8956.417832840845, 8963.955180224057, 8973.506457144855, 5192.506711862367, 5373.919391209135, 5378.704171270579, 5403.567714582824, 5406.0, 3624.220792529619, 3628.2380700053022, 3697.6856967157823, 3698.7410881238325, 3717.3494638438165, 1080.778440419712, 1084.9891501085046, 1085.6905781852133, 1096.1395304685784, 1107.1530279336314, 11527.942360288229, 11615.303081815033, 11693.941530292293, 11720.941395293054, 11746.823797643128, 4545.772711364419, 4640.2807564826835, 4840.75796210188, 4846.297286893451, 4854.077725232265, 9863.210943124534, 9956.103950644332, 9959.651412200683, 9970.40177589347, 9971.700848974397, 5337.226102215157, 5365.839024829262, 5372.409035006146, 5391.703456309862, 5396.271503347077, 4418.138462999748, 4761.857144285677, 4868.2210846264425, 4922.384701912261, 4929.137400954819, 3883.76697398157, 3930.4300876372768, 4018.7588744675413, 4074.144429669743, 4078.938815917764, 1270.4092596942467, 1274.949002039908, 1275.1902541885784, 1285.5821857896035, 1292.424870932445, 779.5439667794403, 859.441363113981, 874.1477059866706, 901.9413738107002, 906.5648488725449, 5828.358880523139, 5880.558958078162, 5937.0203916354185, 6057.3336932937345, 6211.223597050369, 430.99784501077295, 433.9804708788112, 441.63785695729194, 454.1167429349949, 454.7953420960581, 3969.54350249725, 3976.980115099464, 4066.2070896175555, 4110.609492098246, 4121.196366708523, 10455.961087587999, 10574.101201397814, 10667.306625069346, 10694.0, 10728.678139655824, 10645.0951669109, 10646.254762166574, 10647.94676026615, 10649.361038337725, 10661.84007239892, 6385.553011289165, 8168.754937351889, 8183.140770219041, 8267.0, 8273.296769774517, 5979.790707325223, 6055.333913269449, 6085.269767627913, 6165.475934545614, 6217.253929528486, 9758.219342452445, 9905.356151850106, 9985.500724963578, 10056.899431005597, 10123.392596444237, 8052.396070294869, 8269.95865020671, 10255.282130250811, 10269.075783179549, 10410.583576656849, 7032.472564557576, 7635.42734294919, 7654.846903061796, 7676.692932282646, 7692.230776922263, 7790.454668173174, 8335.624896879775, 8373.706920257762, 8387.454815436977, 8427.5786210688, 7278.417726581755, 7370.6683199255085, 7451.515651482637, 7535.585542795199, 7642.4650274480255, 7200.351968322876, 7364.852702946018, 7398.778036658909, 7485.0, 7486.0, 6911.723531058701, 7024.4029257513685, 7052.471064670068, 7059.682314295766, 7071.893921591078, 4968.527989841104, 4995.275685025724, 5042.697438153576, 5111.718855462986, 5125.231215317732, 4969.428515720739, 4999.200127979506, 5154.716490593053, 5202.869928251824, 5209.973950130225], "value": 4512.567151944985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.3376852734139, 302.4253917556643, 309.1390477520107, 310.1038000179481, 312.0482528288719, 5361.7587208575615, 5458.208559758833, 5497.587680923932, 5635.380108188101, 5640.802571909984, 5045.234168041184, 5157.200633901742, 5443.428440013801, 5561.5828812839, 5569.582281328896, 3541.7874927504304, 3711.740178187528, 4217.536071032199, 4284.143171365739, 4289.828406863721, 3401.489776533515, 3889.630485103925, 4220.198162349159, 4305.526392096883, 4320.638998715394, 3601.56781186258, 4053.777042262689, 4149.97925010376, 4203.4325366075645, 4204.2432362174795, 3430.5540279763723, 4190.706650534479, 4206.684498662582, 4244.681648876316, 4246.596573325529, 3626.2384899171207, 3627.963720362789, 3637.909052273688, 3640.8179591020607, 3643.43526753351, 5297.258383826267, 5383.380911195184, 5430.42980487051, 5441.782328706847, 5455.8363249102595, 3986.388915260509, 4201.831926722927, 4409.713368631061, 4644.164050470914, 4826.541478559531, 4626.583607475343, 5066.82266120684, 5382.730863456812, 5877.706114694291, 5914.467697907209, 3051.359214564944, 3637.3270944875285, 3762.1535154590274, 3918.647321741057, 3959.208158368338, 5671.432856714337, 5737.164107485606, 5906.291245050578, 6151.815445536641, 6242.972158503122, 3400.897973060812, 3523.224890524081, 4002.599740025974, 4025.255327764373, 4035.4552135461336, 3765.736398452082, 3981.1838573092446, 4074.4499492568716, 4074.8777536673947, 4076.429299898017, 4741.767140543415, 4749.24012158053, 4804.231322988375, 4811.855644330676, 4824.215040435061, 5362.383325917492, 5421.864453388697, 5646.6047376684055, 5926.496247818984, 6000.939990600038, 1241.6647505173553, 1368.842583102936, 1378.9241591712553, 1385.8267716535433, 1392.436063394327, 818.9918100819035, 865.4417900454172, 881.5988725130051, 931.1712575807537, 933.5892207428709, 4644.744539050317, 5063.797448102108, 5100.903305789273, 5421.972890135524, 5468.648481153143, 5444.50999410055, 5538.861528461821, 6034.978282275487, 6038.698065096728, 6072.726727297194, 4858.927116093261, 5202.505761952609, 5312.3890752563175, 5490.835274941758, 5495.697736624524, 2821.730221400378, 2880.337522369825, 2972.346083861547, 3270.378628060661, 3273.1326198556926, 5759.452851979056, 5859.677717725566, 6394.776182833579, 6441.774537891245, 6485.513586481033, 5522.779088836482, 5539.725863051521, 6333.841653958596, 6355.3009168991375, 6362.395572420613, 5546.833594992157, 5635.492805647429, 5836.533077353802, 6368.853606350716, 6469.762305689781, 4686.882827929193, 5607.859803504782, 5635.6323849017335, 5734.738357561329, 6118.552578968271, 5014.373203349582, 6038.849028774316, 6050.969745151246, 6128.8774224516155, 6164.352742961924, 6045.848853778691, 6124.775044990931, 6238.906416403848, 6414.75483580743, 6536.705848236746, 3331.0839519131464, 3714.9226724249665, 3971.980140099281, 4004.739691920016, 4029.456023436916, 4607.838725644587, 5618.915716264178, 6181.856356574048, 6194.81415557534, 6219.662772503933, 5801.883962320646, 5905.40945905406, 5942.7920022799, 5994.580379373402, 6006.789762358297, 4771.4512831023485, 5633.577561648367, 6015.4586087252355, 6039.305479869696, 6047.818565443044, 5519.123498010696, 5555.749991250323, 5750.0, 5770.451807078321, 5829.271341082364, 5620.662760234399, 5948.672822994777, 5992.561785171614, 6016.548758843017, 6050.515958723204, 4997.0, 5399.352077750695, 5474.452554744494, 5761.55134068011, 5869.3859188723445], "value": 4233.395653857475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9312004544119, 719.4244604316546, 732.1616748822602, 764.5374548398219, 812.1229072601589, 15188.696226075486, 15978.041317520956, 16140.354385824583, 16151.515454536353, 16835.41076062338, 15857.762133567976, 16084.678306433865, 16406.589835254093, 16490.0, 16516.174191290447, 833.9617176615122, 856.1010938514565, 858.5578427110044, 858.7938894665298, 859.1966511311912, 660.2308310817891, 830.7923019245188, 853.0616322045731, 854.239726643288, 860.7977125375531, 896.4710820615835, 898.290350623007, 899.7660608241839, 901.6708901251029, 905.0768216419249, 881.8721285413579, 894.5214310343999, 895.5969813583881, 897.7082448204294, 899.4423457456386, 655.7540922154192, 666.4901350466897, 667.4126768443787, 668.478586702368, 668.7893313606247, 13942.67544583263, 15196.316165772567, 15208.771868421982, 15321.846781532153, 15327.386904523806, 11474.909883561048, 12280.0, 12547.623571292876, 12552.560660376934, 14383.856161438356, 10961.83450288893, 11413.771724565546, 11447.370394628291, 11473.885261147365, 11593.420328983602, 3814.893680832555, 3832.6933845292588, 3844.6347596978244, 3856.84572617095, 3987.5613682494904, 115121.0, 116462.0, 117351.41324293324, 120906.18640720485, 121041.39479302547, 9055.728328150166, 10763.946180269206, 10910.509027093642, 11083.944580277048, 11308.943455282671, 18073.909630452028, 22208.11167553312, 22263.109475620793, 22305.776942230368, 22360.664590031163, 7660.885086723703, 7999.480033797785, 8039.236272554098, 8215.260626543639, 8286.337093032544, 4470.798814053375, 4472.08322293929, 4476.686631935799, 4485.0805584855025, 4496.662750293741, 3586.6951309139017, 3695.6489133532273, 3734.1598140418732, 3757.455169000534, 3761.360568703327, 603.432773193197, 675.5136301862651, 686.4508393285352, 693.8987323004009, 699.9055127557816, 530.3132443485619, 591.204829504316, 643.8744444833212, 673.2426020726682, 675.76010516267, 7767.689292428353, 8501.787455313666, 9684.854727179098, 9711.5144242789, 9893.356931799553, 558.6396774080695, 587.9941200588025, 680.5424469723391, 684.7877158081011, 695.422799076765, 3624.571537070169, 4529.68292219548, 4767.750563906011, 4776.8566942991765, 4781.737004464788, 159521.40478595297, 160739.0, 161444.0, 163747.0, 164331.1783441099, 135400.0, 135598.0, 137413.0, 138724.0, 140233.43291285078, 86034.0, 95361.5231923836, 100147.4977875347, 110217.44891275492, 122060.0, 9375.046860239003, 9640.71077867665, 9829.480447457843, 10028.22397992965, 10125.89874101279, 47180.52819471761, 48078.75960620175, 56965.71517142554, 60127.098093527755, 65523.80952380953, 97987.0, 99824.50087749514, 101336.98663013276, 101452.0, 101752.80719120742, 10935.617253396093, 12499.93750031244, 13008.0, 13120.212787232414, 13724.794128087888, 14709.55871323862, 14720.337584808924, 14766.852331476548, 15009.924950375615, 15118.900625371993, 11656.708582285171, 12878.613641590768, 13818.792718109034, 13911.721765564429, 14198.716025679636, 12081.973032292353, 12446.25322480654, 12621.558245461365, 13947.860521394656, 14529.200893950934, 12605.68485787826, 13726.89042291491, 13767.724645506833, 13797.862021379658, 14065.648358791112, 11155.83266251023, 11243.212975091992, 11291.3789741565, 11297.345123895713, 11582.204758262145, 8751.387402881737, 11256.0, 11384.089272858317, 11588.94205528967, 11615.36115513621], "value": 7846.354025106233, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 117.0, 116.0, 117.0, 116.0, 98.0, 176.0, 111.0, 193.0], "value": 127.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 136.0, 158.0, 119.0, 129.0, 128.0, 146.0, 205.0, 134.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 202.0, 229.0, 199.0, 201.0, 236.0, 276.0, 197.0, 189.0, 189.0], "value": 211.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 86.0, 96.0, 184.0, 52.0, 60.0, 83.0, 89.0, 163.0, 51.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 126.0, 69.0, 70.0, 83.0, 113.0, 68.0, 72.0, 112.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 107.0, 136.0, 89.0, 90.0, 101.0, 92.0, 87.0, 93.0, 88.0], "value": 97.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 92.0, 154.0, 152.0, 105.0, 153.0, 97.0, 154.0, 153.0, 115.0], "value": 130.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 110.0, 90.0, 93.0, 92.0, 90.0, 92.0, 92.0, 90.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 56.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 77.0, 70.0, 81.0, 81.0, 80.0, 74.0, 82.0, 85.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 87.0, 86.0, 86.0, 90.0, 90.0, 90.0, 92.0, 91.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 159.0, 161.0, 131.0, 179.0, 165.0, 166.0, 159.0, 198.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 176.0, 173.0, 174.0, 171.0, 156.0, 216.0, 216.0, 176.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 87.0, 75.0, 68.0, 69.0, 62.0, 67.0, 89.0, 100.0, 79.0], "value": 76.4, "unit": "score"}]}]} 20:13:28 INFO - Return code: 0 20:13:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:13:28 ERROR - # TBPL SUCCESS # 20:13:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:13:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:13:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:13:28 INFO - 2016-08-26 20:13:28.369 screenresolution[2226:32722] starting screenresolution argv=screenresolution get 20:13:28 INFO - 2016-08-26 20:13:28.372 screenresolution[2226:32722] Display 0: 1600x1200x32@60 20:13:28 INFO - 2016-08-26 20:13:28.379 screenresolution[2227:32725] starting screenresolution argv=screenresolution list 20:13:28 INFO - Available Modes on Display 0 20:13:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:13:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:13:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:13:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:13:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:13:28 INFO - Intel Iris: 20:13:28 INFO - Chipset Model: Intel Iris 20:13:28 INFO - Type: GPU 20:13:28 INFO - Bus: Built-In 20:13:28 INFO - VRAM (Dynamic, Max): 1536 MB 20:13:28 INFO - Vendor: Intel (0x8086) 20:13:28 INFO - Device ID: 0x0a2e 20:13:28 INFO - Revision ID: 0x0009 20:13:28 INFO - Displays: 20:13:28 INFO - Display: 20:13:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:13:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:13:28 INFO - Display Serial Number: 1600x1200 60 20:13:28 INFO - Main Display: Yes 20:13:28 INFO - Mirror: Off 20:13:28 INFO - Online: Yes 20:13:28 INFO - Rotation: Supported 20:13:28 INFO - Return code: 0 20:13:28 INFO - Running post-action listener: _resource_record_post_action 20:13:28 INFO - [mozharness: 2016-08-27 03:13:28.615698Z] Finished run-tests step (success) 20:13:28 INFO - Running post-run listener: _resource_record_post_run 20:13:28 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 11781120; Write bytes: 719692288; Read time: 137; Write time: 2138 20:13:28 INFO - TinderboxPrint: CPU usage
54.2% 20:13:28 INFO - TinderboxPrint: I/O read bytes / time
11,781,120 / 137 20:13:28 INFO - TinderboxPrint: I/O write bytes / time
719,692,288 / 2,138 20:13:28 INFO - TinderboxPrint: CPU idle
2,219.4 (45.8%) 20:13:28 INFO - TinderboxPrint: CPU system
976.9 (20.2%) 20:13:28 INFO - TinderboxPrint: CPU user
1,645.4 (34.0%) 20:13:28 INFO - TinderboxPrint: Swap in / out
410,099,712 / 0 20:13:28 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 385917440; Write bytes: 381383680; Read time: 28906; Write time: 828 20:13:28 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 11781120; Write bytes: 309992960; Read time: 137; Write time: 1242 20:13:29 INFO - Running post-run listener: _upload_blobber_files 20:13:29 INFO - Blob upload gear active. 20:13:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:13:29 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 20:13:29 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:13:29 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:13:29 INFO - (blobuploader) - INFO - Open directory for files ... 20:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:13:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:13:30 INFO - (blobuploader) - INFO - Done attempting. 20:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:13:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:13:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:13:31 INFO - (blobuploader) - INFO - Done attempting. 20:13:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:13:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:13:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:13:33 INFO - (blobuploader) - INFO - Done attempting. 20:13:33 INFO - (blobuploader) - INFO - Iteration through files over. 20:13:33 INFO - Return code: 0 20:13:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:13:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:13:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b7436bcb6429366d6854112e63236c497ea09cc4cf05603b6146fa80715f318c4b82aba07f0dd808ea55a1be5479047b13c554bc69758bc6578f8eb8503c485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a92d616d35144ac207cd357e772fb35a1cfd5e69019f0ae7360592d7a02562d35f7fc03940b0e9a128fd8008278b9ac23f0385d349ffb3bc6f778c3ea60b31f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b79c4a08749966128f488e9ec1a4997b9196708613c1831dc8c5b9338453049d05b1f48433bb87a61b01c72964aefbc442e9d6f586290ddaf89a4bbe1cedc6"} 20:13:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:13:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:13:33 INFO - Contents: 20:13:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b7436bcb6429366d6854112e63236c497ea09cc4cf05603b6146fa80715f318c4b82aba07f0dd808ea55a1be5479047b13c554bc69758bc6578f8eb8503c485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a92d616d35144ac207cd357e772fb35a1cfd5e69019f0ae7360592d7a02562d35f7fc03940b0e9a128fd8008278b9ac23f0385d349ffb3bc6f778c3ea60b31f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b79c4a08749966128f488e9ec1a4997b9196708613c1831dc8c5b9338453049d05b1f48433bb87a61b01c72964aefbc442e9d6f586290ddaf89a4bbe1cedc6"} 20:13:33 INFO - Running post-run listener: copy_logs_to_upload_dir 20:13:33 INFO - Copying logs to upload dir... 20:13:33 INFO - mkdir: /builds/slave/test/build/upload/logs 20:13:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.824974 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-26 20:13:33.974146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 20:13:33.977848) ========= 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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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/Fx-Team/sha512/7b7436bcb6429366d6854112e63236c497ea09cc4cf05603b6146fa80715f318c4b82aba07f0dd808ea55a1be5479047b13c554bc69758bc6578f8eb8503c485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a92d616d35144ac207cd357e772fb35a1cfd5e69019f0ae7360592d7a02562d35f7fc03940b0e9a128fd8008278b9ac23f0385d349ffb3bc6f778c3ea60b31f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b79c4a08749966128f488e9ec1a4997b9196708613c1831dc8c5b9338453049d05b1f48433bb87a61b01c72964aefbc442e9d6f586290ddaf89a4bbe1cedc6"} build_url:https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/LB-bb2weSB6esLBqLaCTsA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b7436bcb6429366d6854112e63236c497ea09cc4cf05603b6146fa80715f318c4b82aba07f0dd808ea55a1be5479047b13c554bc69758bc6578f8eb8503c485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a92d616d35144ac207cd357e772fb35a1cfd5e69019f0ae7360592d7a02562d35f7fc03940b0e9a128fd8008278b9ac23f0385d349ffb3bc6f778c3ea60b31f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b79c4a08749966128f488e9ec1a4997b9196708613c1831dc8c5b9338453049d05b1f48433bb87a61b01c72964aefbc442e9d6f586290ddaf89a4bbe1cedc6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 20:13:34.011085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 20:13:34.011453) ========= 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.TZuM9PFHsP/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.w8oDT1xHGG/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.004366 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 20:13:34.060391) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 20:13:34.060740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 20:13:34.061091) ========= ========= Total master_lag: 0.20 =========