builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0135 starttime: 1472324205.37 results: success (0) buildid: 20160827100114 builduid: bc21ac6ddd1d4b3d80ac93bcd98e8f0b revision: bbbaa584248f10687f5e609c8252c84f5317515c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:45.372020) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:45.372484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:45.372763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:45.549614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:45.549946) ========= 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.skeAxptiIX/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.geA5rIImJh/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-27 11:56:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 72.8M=0s 2016-08-27 11:56:46 (72.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.541896 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:46.119742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:46.120061) ========= 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.skeAxptiIX/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.geA5rIImJh/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.032910 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:46.173767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-27 11:56:46.174121) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bbbaa584248f10687f5e609c8252c84f5317515c --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 bbbaa584248f10687f5e609c8252c84f5317515c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.skeAxptiIX/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.geA5rIImJh/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-27 11:56:46,250 truncating revision to first 12 chars 2016-08-27 11:56:46,250 Setting DEBUG logging. 2016-08-27 11:56:46,250 attempt 1/10 2016-08-27 11:56:46,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bbbaa584248f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 11:56:47,314 unpacking tar archive at: fx-team-bbbaa584248f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.317025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-27 11:56:47.511907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:47.512224) ========= script_repo_revision: bbbaa584248f10687f5e609c8252c84f5317515c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:47.512602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:47.512864) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 11:56:47.532229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-27 11:56:47.532623) ========= /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.skeAxptiIX/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.geA5rIImJh/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:56:47 INFO - MultiFileLogger online at 20160827 11:56:47 in /builds/slave/test 11:56:47 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 11:56:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:56:47 INFO - {'append_to_log': False, 11:56:47 INFO - 'base_work_dir': '/builds/slave/test', 11:56:47 INFO - 'blob_upload_branch': 'Fx-Team', 11:56:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:56:47 INFO - 'branch': 'Fx-Team', 11:56:47 INFO - 'buildbot_json_path': 'buildprops.json', 11:56:47 INFO - 'config_files': ('talos/mac_config.py',), 11:56:47 INFO - 'default_actions': ('clobber', 11:56:47 INFO - 'read-buildbot-config', 11:56:47 INFO - 'download-and-extract', 11:56:47 INFO - 'populate-webroot', 11:56:47 INFO - 'create-virtualenv', 11:56:47 INFO - 'install', 11:56:47 INFO - 'run-tests'), 11:56:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:56:47 INFO - 'download_minidump_stackwalk': True, 11:56:47 INFO - 'download_symbols': 'ondemand', 11:56:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:56:47 INFO - 'tooltool.py': '/tools/tooltool.py', 11:56:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:56:47 INFO - '/tools/misc-python/virtualenv.py')}, 11:56:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:56:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:56:47 INFO - 'installer_path': 'installer.exe', 11:56:47 INFO - 'log_level': 'info', 11:56:47 INFO - 'log_name': 'talos', 11:56:47 INFO - 'log_to_console': True, 11:56:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:56:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:56:47 INFO - 'opt_config_files': (), 11:56:47 INFO - 'pip_index': False, 11:56:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:56:47 INFO - 'cmd': ('bash', 11:56:47 INFO - '-c', 11:56:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:56:47 INFO - 'enabled': True, 11:56:47 INFO - 'halt_on_failure': False, 11:56:47 INFO - 'name': 'check_screen_resolution'},), 11:56:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:56:47 INFO - 'cmd': ('bash', 11:56:47 INFO - '-c', 11:56:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:56:47 INFO - 'enabled': True, 11:56:47 INFO - 'halt_on_failure': False, 11:56:47 INFO - 'name': 'check_screen_resolution'},), 11:56:47 INFO - 'run_cmd_checks_enabled': True, 11:56:47 INFO - 'sps_profile': False, 11:56:47 INFO - 'sps_profile_interval': 0, 11:56:47 INFO - 'suite': 'dromaeojs-e10s', 11:56:47 INFO - 'system_bits': '32', 11:56:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:56:47 INFO - 'title': 't-yosemite-r7-0135', 11:56:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:56:47 INFO - 'use_talos_json': True, 11:56:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:56:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:56:47 INFO - 'work_dir': 'build'} 11:56:47 INFO - [mozharness: 2016-08-27 18:56:47.730735Z] Running clobber step. 11:56:47 INFO - Running pre-action listener: _resource_record_pre_action 11:56:47 INFO - Running main action method: clobber 11:56:47 INFO - rmtree: /builds/slave/test/build 11:56:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:56:50 INFO - Running post-action listener: _resource_record_post_action 11:56:50 INFO - [mozharness: 2016-08-27 18:56:50.263044Z] Finished clobber step (success) 11:56:50 INFO - [mozharness: 2016-08-27 18:56:50.263207Z] Running read-buildbot-config step. 11:56:50 INFO - Running pre-action listener: _resource_record_pre_action 11:56:50 INFO - Running main action method: read_buildbot_config 11:56:50 INFO - Using buildbot properties: 11:56:50 INFO - { 11:56:50 INFO - "project": "", 11:56:50 INFO - "product": "firefox", 11:56:50 INFO - "script_repo_revision": "production", 11:56:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:56:50 INFO - "repository": "", 11:56:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:56:50 INFO - "buildid": "20160827100114", 11:56:50 INFO - "pgo_build": "False", 11:56:50 INFO - "basedir": "/builds/slave/test", 11:56:50 INFO - "buildnumber": 35, 11:56:50 INFO - "slavename": "t-yosemite-r7-0135", 11:56:50 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:56:50 INFO - "platform": "yosemite_r7", 11:56:50 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:56:50 INFO - "branch": "fx-team", 11:56:50 INFO - "repo_path": "integration/fx-team", 11:56:50 INFO - "revision": "bbbaa584248f10687f5e609c8252c84f5317515c", 11:56:50 INFO - "stage_platform": "macosx64", 11:56:50 INFO - "builduid": "bc21ac6ddd1d4b3d80ac93bcd98e8f0b", 11:56:50 INFO - "slavebuilddir": "test" 11:56:50 INFO - } 11:56:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:56:50 INFO - Running post-action listener: _resource_record_post_action 11:56:50 INFO - [mozharness: 2016-08-27 18:56:50.266584Z] Finished read-buildbot-config step (success) 11:56:50 INFO - [mozharness: 2016-08-27 18:56:50.266701Z] Running download-and-extract step. 11:56:50 INFO - Running pre-action listener: _resource_record_pre_action 11:56:50 INFO - Running main action method: download_and_extract 11:56:50 INFO - mkdir: /builds/slave/test/build/tests 11:56: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')]} 11:56:50 INFO - trying https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:56:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:56:51 INFO - Downloaded 1199 bytes. 11:56:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:56:51 INFO - Using the following test package requirements: 11:56:51 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:56:51 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:56:51 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:56:51 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'jsshell-mac.zip'], 11:56:51 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:56:51 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:56:51 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:56:51 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:56:51 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:56:51 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:56:51 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:56:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:56:51 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')]} 11:56:51 INFO - trying https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:56:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:56:52 INFO - Downloaded 16369340 bytes. 11:56:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:56:59 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 11:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:59 INFO - trying https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:56:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:57:00 INFO - Downloaded 16369340 bytes. 11:57:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:57: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')]} 11:57:06 INFO - trying https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:57:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:57:08 INFO - Downloaded 14413998 bytes. 11:57:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:08 INFO - trying https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:57:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/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 11:57:11 INFO - Downloaded 111547107 bytes. 11:57:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:57:11 INFO - mkdir: /builds/slave/test/properties 11:57:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:11 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:11 INFO - Contents: 11:57:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:57:12 INFO - Running post-action listener: _resource_record_post_action 11:57:12 INFO - Running post-action listener: set_extra_try_arguments 11:57:12 INFO - [mozharness: 2016-08-27 18:57:12.451290Z] Finished download-and-extract step (success) 11:57:12 INFO - [mozharness: 2016-08-27 18:57:12.451434Z] Running populate-webroot step. 11:57:12 INFO - Running pre-action listener: _resource_record_pre_action 11:57:12 INFO - Running main action method: populate_webroot 11:57:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:57:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:57:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:57:12 INFO - '--tppagecycles', 11:57:12 INFO - '7'], 11:57:12 INFO - 'tests': ['tsvgm']}}, 11:57:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:57:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:57:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['damp', 'tps']}, 11:57:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'tests': ['damp', 'tps']}, 11:57:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['dromaeo_dom']}, 11:57:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['basic_compositor_video']}, 11:57:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:57:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['a11yr', 11:57:12 INFO - 'ts_paint', 11:57:12 INFO - 'tpaint', 11:57:12 INFO - 'sessionrestore', 11:57:12 INFO - 'sessionrestore_no_auto_restore', 11:57:12 INFO - 'tabpaint']}, 11:57:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:12 INFO - 'ts_paint', 11:57:12 INFO - 'tpaint', 11:57:12 INFO - 'sessionrestore', 11:57:12 INFO - 'sessionrestore_no_auto_restore', 11:57:12 INFO - 'tabpaint']}, 11:57:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:57:12 INFO - 'ts_paint', 11:57:12 INFO - 'tpaint', 11:57:12 INFO - 'sessionrestore', 11:57:12 INFO - 'sessionrestore_no_auto_restore', 11:57:12 INFO - 'tabpaint']}, 11:57:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:57:12 INFO - 'ts_paint', 11:57:12 INFO - 'tpaint', 11:57:12 INFO - 'sessionrestore', 11:57:12 INFO - 'sessionrestore_no_auto_restore', 11:57:12 INFO - 'tabpaint']}, 11:57:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['a11yr', 11:57:12 INFO - 'ts_paint', 11:57:12 INFO - 'tpaint', 11:57:12 INFO - 'sessionrestore', 11:57:12 INFO - 'sessionrestore_no_auto_restore', 11:57:12 INFO - 'tabpaint']}, 11:57:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['a11yr', 11:57:12 INFO - 'ts_paint', 11:57:12 INFO - 'tpaint', 11:57:12 INFO - 'sessionrestore', 11:57:12 INFO - 'sessionrestore_no_auto_restore', 11:57:12 INFO - 'tabpaint']}, 11:57:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['tsvgx', 11:57:12 INFO - 'tsvgr_opacity', 11:57:12 INFO - 'tart', 11:57:12 INFO - 'tscrollx', 11:57:12 INFO - 'cart']}, 11:57:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:12 INFO - 'tsvgr_opacity', 11:57:12 INFO - 'tart', 11:57:12 INFO - 'tscrollx', 11:57:12 INFO - 'cart']}, 11:57:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'talos_options': ['--disable-e10s'], 11:57:12 INFO - 'tests': ['tp5o']}, 11:57:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'tests': ['tp5o']}, 11:57:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'talos_options': ['--disable-e10s', 11:57:12 INFO - '--xperf_path', 11:57:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:12 INFO - 'tests': ['tp5n']}, 11:57:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:12 INFO - 'talos_options': ['--xperf_path', 11:57:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:12 INFO - 'tests': ['tp5n']}}, 11:57:12 INFO - 'talos.zip': {'path': '', 11:57:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:57:12 INFO - Running post-action listener: _resource_record_post_action 11:57:12 INFO - [mozharness: 2016-08-27 18:57:12.469391Z] Finished populate-webroot step (success) 11:57:12 INFO - [mozharness: 2016-08-27 18:57:12.469500Z] Running create-virtualenv step. 11:57:12 INFO - Running pre-action listener: _resource_record_pre_action 11:57:12 INFO - Running main action method: create_virtualenv 11:57:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:12 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 11:57:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:57:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:12 INFO - Using real prefix '/tools/python27' 11:57:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:57:16 INFO - Installing pip.................done. 11:57:16 INFO - Return code: 0 11:57:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:57: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')]} 11:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57: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')]} 11:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:16 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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:16 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 11:57:16 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 11:57:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:16 INFO - 'HOME': '/Users/cltbld', 11:57:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:16 INFO - 'LOGNAME': 'cltbld', 11:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:16 INFO - 'MOZ_NO_REMOTE': '1', 11:57:16 INFO - 'NO_EM_RESTART': '1', 11:57:16 INFO - 'PAGER': '/bin/cat', 11:57:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:16 INFO - 'PWD': '/builds/slave/test', 11:57:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:16 INFO - 'SHELL': '/bin/bash', 11:57:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:16 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:16 INFO - 'USER': 'cltbld', 11:57:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:16 INFO - 'XPC_FLAGS': '0x0', 11:57:16 INFO - 'XPC_SERVICE_NAME': '0', 11:57:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:16 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 11:57:16 INFO - Cleaning up... 11:57:16 INFO - Return code: 0 11:57:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:57: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')]} 11:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57: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')]} 11:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:16 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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:16 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 11:57:16 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 11:57:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:16 INFO - 'HOME': '/Users/cltbld', 11:57:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:16 INFO - 'LOGNAME': 'cltbld', 11:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:16 INFO - 'MOZ_NO_REMOTE': '1', 11:57:16 INFO - 'NO_EM_RESTART': '1', 11:57:16 INFO - 'PAGER': '/bin/cat', 11:57:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:16 INFO - 'PWD': '/builds/slave/test', 11:57:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:16 INFO - 'SHELL': '/bin/bash', 11:57:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:16 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:16 INFO - 'USER': 'cltbld', 11:57:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:16 INFO - 'XPC_FLAGS': '0x0', 11:57:16 INFO - 'XPC_SERVICE_NAME': '0', 11:57:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:16 INFO - Downloading/unpacking psutil>=3.1.1 11:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:57:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:19 INFO - Installing collected packages: psutil 11:57:19 INFO - Running setup.py install for psutil 11:57:19 INFO - building 'psutil._psutil_osx' extension 11:57:19 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 11:57:20 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 11:57:20 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 11:57:20 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 11:57:20 INFO - building 'psutil._psutil_posix' extension 11:57:20 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 11:57:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:57:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:57:20 INFO - ^ 11:57:20 INFO - 1 warning generated. 11:57:20 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 11:57:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:20 INFO - Successfully installed psutil 11:57:20 INFO - Cleaning up... 11:57:20 INFO - Return code: 0 11:57:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:20 INFO - 'HOME': '/Users/cltbld', 11:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:20 INFO - 'LOGNAME': 'cltbld', 11:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:20 INFO - 'MOZ_NO_REMOTE': '1', 11:57:20 INFO - 'NO_EM_RESTART': '1', 11:57:20 INFO - 'PAGER': '/bin/cat', 11:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:20 INFO - 'PWD': '/builds/slave/test', 11:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:20 INFO - 'SHELL': '/bin/bash', 11:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:20 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:20 INFO - 'USER': 'cltbld', 11:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:20 INFO - 'XPC_FLAGS': '0x0', 11:57:20 INFO - 'XPC_SERVICE_NAME': '0', 11:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:57:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:57:23 INFO - Installing collected packages: mozsystemmonitor 11:57:23 INFO - Running setup.py install for mozsystemmonitor 11:57:23 INFO - Successfully installed mozsystemmonitor 11:57:23 INFO - Cleaning up... 11:57:24 INFO - Return code: 0 11:57:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:57: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')]} 11:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57: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')]} 11:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:24 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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:24 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 11:57:24 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 11:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:24 INFO - 'HOME': '/Users/cltbld', 11:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:24 INFO - 'LOGNAME': 'cltbld', 11:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:24 INFO - 'MOZ_NO_REMOTE': '1', 11:57:24 INFO - 'NO_EM_RESTART': '1', 11:57:24 INFO - 'PAGER': '/bin/cat', 11:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:24 INFO - 'PWD': '/builds/slave/test', 11:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:24 INFO - 'SHELL': '/bin/bash', 11:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:24 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:24 INFO - 'USER': 'cltbld', 11:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:24 INFO - 'XPC_FLAGS': '0x0', 11:57:24 INFO - 'XPC_SERVICE_NAME': '0', 11:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:24 INFO - Downloading/unpacking jsonschema==2.5.1 11:57:24 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 11:57:24 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 11:57:24 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 11:57:24 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 11:57:24 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 11:57:24 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 11:57:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:57:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:57:26 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 11:57:26 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 11:57:26 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 11:57:26 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 11:57:26 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 11:57:26 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 11:57:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:57:27 INFO - warning: no files found matching '*.txt' 11:57:27 INFO - no previously-included directories found matching 'build' 11:57:27 INFO - no previously-included directories found matching 'dist' 11:57:27 INFO - no previously-included directories found matching '.git*' 11:57:27 INFO - Installing collected packages: jsonschema, functools32 11:57:27 INFO - Running setup.py install for functools32 11:57:27 INFO - warning: no files found matching '*.txt' 11:57:27 INFO - no previously-included directories found matching 'build' 11:57:27 INFO - no previously-included directories found matching 'dist' 11:57:27 INFO - no previously-included directories found matching '.git*' 11:57:27 INFO - Successfully installed jsonschema functools32 11:57:27 INFO - Cleaning up... 11:57:27 INFO - Return code: 0 11:57:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:57:27 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')]} 11:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:27 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')]} 11:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:27 INFO - 'HOME': '/Users/cltbld', 11:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:27 INFO - 'LOGNAME': 'cltbld', 11:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:27 INFO - 'MOZ_NO_REMOTE': '1', 11:57:27 INFO - 'NO_EM_RESTART': '1', 11:57:27 INFO - 'PAGER': '/bin/cat', 11:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:27 INFO - 'PWD': '/builds/slave/test', 11:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:27 INFO - 'SHELL': '/bin/bash', 11:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:27 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:27 INFO - 'USER': 'cltbld', 11:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:27 INFO - 'XPC_FLAGS': '0x0', 11:57:27 INFO - 'XPC_SERVICE_NAME': '0', 11:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:57:27 INFO - Cleaning up... 11:57:27 INFO - Return code: 0 11:57:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:57:27 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')]} 11:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:27 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')]} 11:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:27 INFO - 'HOME': '/Users/cltbld', 11:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:27 INFO - 'LOGNAME': 'cltbld', 11:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:27 INFO - 'MOZ_NO_REMOTE': '1', 11:57:27 INFO - 'NO_EM_RESTART': '1', 11:57:27 INFO - 'PAGER': '/bin/cat', 11:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:27 INFO - 'PWD': '/builds/slave/test', 11:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:27 INFO - 'SHELL': '/bin/bash', 11:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:27 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:27 INFO - 'USER': 'cltbld', 11:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:27 INFO - 'XPC_FLAGS': '0x0', 11:57:27 INFO - 'XPC_SERVICE_NAME': '0', 11:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:57:28 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 11:57:28 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 11:57:28 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 11:57:28 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 11:57:28 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 11:57:28 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 11:57:30 INFO - Downloading blobuploader-1.2.4.tar.gz 11:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:57:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:57:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:31 INFO - Downloading docopt-0.6.1.tar.gz 11:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:57:31 INFO - Installing collected packages: blobuploader, requests, docopt 11:57:31 INFO - Running setup.py install for blobuploader 11:57:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:57:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:57:31 INFO - Running setup.py install for requests 11:57:32 INFO - Running setup.py install for docopt 11:57:32 INFO - Successfully installed blobuploader requests docopt 11:57:32 INFO - Cleaning up... 11:57:32 INFO - Return code: 0 11:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:32 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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:32 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 11:57:32 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 11:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:32 INFO - 'HOME': '/Users/cltbld', 11:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:32 INFO - 'LOGNAME': 'cltbld', 11:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:32 INFO - 'MOZ_NO_REMOTE': '1', 11:57:32 INFO - 'NO_EM_RESTART': '1', 11:57:32 INFO - 'PAGER': '/bin/cat', 11:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:32 INFO - 'PWD': '/builds/slave/test', 11:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:32 INFO - 'SHELL': '/bin/bash', 11:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:32 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:32 INFO - 'USER': 'cltbld', 11:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:32 INFO - 'XPC_FLAGS': '0x0', 11:57:32 INFO - 'XPC_SERVICE_NAME': '0', 11:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-N2ZOlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-qcARq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Pj7Uw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hs_nBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-rtQCzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-m93CJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-03LOZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-etWLz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-uCksMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:33 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Bp1e4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:34 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-a_rNFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:34 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-bAnivJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:34 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-IFEyzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:34 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-BtR3_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:34 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-gaRTN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:34 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-oIvaN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:34 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-eHhCds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:57:34 INFO - Running setup.py install for manifestparser 11:57:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:57:34 INFO - Running setup.py install for mozcrash 11:57:35 INFO - Running setup.py install for mozdebug 11:57:35 INFO - Running setup.py install for mozdevice 11:57:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Running setup.py install for mozfile 11:57:35 INFO - Running setup.py install for mozhttpd 11:57:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Running setup.py install for mozinfo 11:57:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Running setup.py install for mozInstall 11:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:57:35 INFO - Running setup.py install for mozleak 11:57:36 INFO - Running setup.py install for mozlog 11:57:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:57:36 INFO - Running setup.py install for moznetwork 11:57:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:57:36 INFO - Running setup.py install for mozprocess 11:57:36 INFO - Running setup.py install for mozprofile 11:57:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:57:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:57:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:57:36 INFO - Running setup.py install for mozrunner 11:57:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:57:36 INFO - Running setup.py install for mozscreenshot 11:57:37 INFO - Running setup.py install for moztest 11:57:37 INFO - Running setup.py install for mozversion 11:57:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:57:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:57:37 INFO - Cleaning up... 11:57:37 INFO - Return code: 0 11:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:37 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')]} 11:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:37 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')]} 11:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:37 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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:37 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 11:57:37 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 11:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:37 INFO - 'HOME': '/Users/cltbld', 11:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:37 INFO - 'LOGNAME': 'cltbld', 11:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:37 INFO - 'MOZ_NO_REMOTE': '1', 11:57:37 INFO - 'NO_EM_RESTART': '1', 11:57:37 INFO - 'PAGER': '/bin/cat', 11:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:37 INFO - 'PWD': '/builds/slave/test', 11:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:37 INFO - 'SHELL': '/bin/bash', 11:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:37 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:37 INFO - 'USER': 'cltbld', 11:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:37 INFO - 'XPC_FLAGS': '0x0', 11:57:37 INFO - 'XPC_SERVICE_NAME': '0', 11:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:37 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-DHn_68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:37 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)) 11:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:37 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Xfyu4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:37 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)) 11:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:37 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-z85ygn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:37 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)) 11:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:37 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-feUJLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-WvKMC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8cyFKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-DtQ8pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8fJMO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-uaxkSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-umuCsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-mr_OrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-SH71ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:38 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)) 11:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:38 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-oZ4lqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:39 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)) 11:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:39 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-LRai_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:39 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)) 11:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:39 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sY8bOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:39 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)) 11:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:39 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-A3xUaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:39 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)) 11:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:39 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-_HFyZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:57:39 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 11:57:39 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 11:57:39 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 11:57:39 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 11:57:39 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 11:57:39 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 11:57:41 INFO - Downloading blessings-1.6.tar.gz 11:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:57:42 INFO - Installing collected packages: blessings 11:57:42 INFO - Running setup.py install for blessings 11:57:42 INFO - Successfully installed blessings 11:57:42 INFO - Cleaning up... 11:57:42 INFO - Return code: 0 11:57:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:42 INFO - Reading from file tmpfile_stdout 11:57:42 INFO - Current package versions: 11:57:42 INFO - blessings == 1.6 11:57:42 INFO - blobuploader == 1.2.4 11:57:42 INFO - docopt == 0.6.1 11:57:42 INFO - functools32 == 3.2.3-2 11:57:42 INFO - jsonschema == 2.5.1 11:57:42 INFO - manifestparser == 1.1 11:57:42 INFO - mozInstall == 1.12 11:57:42 INFO - mozcrash == 0.17 11:57:42 INFO - mozdebug == 0.1 11:57:42 INFO - mozdevice == 0.48 11:57:42 INFO - mozfile == 1.2 11:57:42 INFO - mozhttpd == 0.7 11:57:42 INFO - mozinfo == 0.9 11:57:42 INFO - mozleak == 0.1 11:57:42 INFO - mozlog == 3.3 11:57:42 INFO - moznetwork == 0.27 11:57:42 INFO - mozprocess == 0.23 11:57:42 INFO - mozprofile == 0.28 11:57:42 INFO - mozrunner == 6.12 11:57:42 INFO - mozscreenshot == 0.1 11:57:42 INFO - mozsystemmonitor == 0.3 11:57:42 INFO - moztest == 0.7 11:57:42 INFO - mozversion == 1.4 11:57:42 INFO - psutil == 3.1.1 11:57:42 INFO - requests == 1.2.3 11:57:42 INFO - wsgiref == 0.1.2 11:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57: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')]} 11:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57: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')]} 11:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:42 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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:42 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 11:57:42 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 11:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:42 INFO - 'HOME': '/Users/cltbld', 11:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:42 INFO - 'LOGNAME': 'cltbld', 11:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:42 INFO - 'MOZ_NO_REMOTE': '1', 11:57:42 INFO - 'NO_EM_RESTART': '1', 11:57:42 INFO - 'PAGER': '/bin/cat', 11:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:42 INFO - 'PWD': '/builds/slave/test', 11:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:42 INFO - 'SHELL': '/bin/bash', 11:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:42 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:42 INFO - 'USER': 'cltbld', 11:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:42 INFO - 'XPC_FLAGS': '0x0', 11:57:42 INFO - 'XPC_SERVICE_NAME': '0', 11:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 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)) 11:57:42 INFO - Cleaning up... 11:57:42 INFO - Return code: 0 11:57:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:57: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')]} 11:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57: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')]} 11:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:42 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 0x107cd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc894d4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, '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.skeAxptiIX/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.geA5rIImJh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 11:57:42 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 11:57:42 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 11:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:42 INFO - 'HOME': '/Users/cltbld', 11:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:42 INFO - 'LOGNAME': 'cltbld', 11:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:42 INFO - 'MOZ_NO_REMOTE': '1', 11:57:42 INFO - 'NO_EM_RESTART': '1', 11:57:42 INFO - 'PAGER': '/bin/cat', 11:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:42 INFO - 'PWD': '/builds/slave/test', 11:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:42 INFO - 'SHELL': '/bin/bash', 11:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:57:42 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:42 INFO - 'USER': 'cltbld', 11:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:42 INFO - 'XPC_FLAGS': '0x0', 11:57:42 INFO - 'XPC_SERVICE_NAME': '0', 11:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:57:43 INFO - Cleaning up... 11:57:43 INFO - Return code: 0 11:57:43 INFO - Running post-action listener: _resource_record_post_action 11:57:43 INFO - Running post-action listener: _start_resource_monitoring 11:57:43 INFO - Starting resource monitoring. 11:57:43 INFO - [mozharness: 2016-08-27 18:57:43.203006Z] Finished create-virtualenv step (success) 11:57:43 INFO - [mozharness: 2016-08-27 18:57:43.203974Z] Running install step. 11:57:43 INFO - Running pre-action listener: _resource_record_pre_action 11:57:43 INFO - Running main action method: install 11:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:43 INFO - Reading from file tmpfile_stdout 11:57:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:57:43 INFO - Reading from file tmpfile_stdout 11:57:43 INFO - Output received: 11:57:43 INFO - Usage: mozinstall [options] installer 11:57:43 INFO - Options: 11:57:43 INFO - -h, --help show this help message and exit 11:57:43 INFO - -d DEST, --destination=DEST 11:57:43 INFO - Directory to install application into. [default: 11:57:43 INFO - "/builds/slave/test"] 11:57:43 INFO - --app=APP Application being installed. [default: firefox] 11:57:43 INFO - mkdir: /builds/slave/test/build/application 11:57:43 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'] 11:57:43 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 11:58:17 INFO - Reading from file tmpfile_stdout 11:58:17 INFO - Output received: 11:58:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:58:17 INFO - Running post-action listener: _resource_record_post_action 11:58:17 INFO - [mozharness: 2016-08-27 18:58:17.922693Z] Finished install step (success) 11:58:17 INFO - [mozharness: 2016-08-27 18:58:17.922847Z] Running run-tests step. 11:58:17 INFO - Running pre-action listener: _resource_record_pre_action 11:58:17 INFO - Running main action method: run_tests 11:58:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:58:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:58:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:58:17 INFO - 2016-08-27 11:58:17.937 screenresolution[1643:7901] starting screenresolution argv=screenresolution get 11:58:17 INFO - 2016-08-27 11:58:17.939 screenresolution[1643:7901] Display 0: 1600x1200x32@60 11:58:17 INFO - 2016-08-27 11:58:17.945 screenresolution[1644:7903] starting screenresolution argv=screenresolution list 11:58:17 INFO - Available Modes on Display 0 11:58:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:58:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:58:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:58:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:58:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:58:18 INFO - Intel Iris: 11:58:18 INFO - Chipset Model: Intel Iris 11:58:18 INFO - Type: GPU 11:58:18 INFO - Bus: Built-In 11:58:18 INFO - VRAM (Dynamic, Max): 1536 MB 11:58:18 INFO - Vendor: Intel (0x8086) 11:58:18 INFO - Device ID: 0x0a2e 11:58:18 INFO - Revision ID: 0x0009 11:58:18 INFO - Displays: 11:58:18 INFO - Display: 11:58:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:58:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:58:18 INFO - Display Serial Number: 1600x1200 60 11:58:18 INFO - Main Display: Yes 11:58:18 INFO - Mirror: Off 11:58:18 INFO - Online: Yes 11:58:18 INFO - Rotation: Supported 11:58:18 INFO - Return code: 0 11:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:58:18 INFO - Python 2.7.3 11:58:18 INFO - Return code: 0 11:58:18 INFO - grabbing minidump binary from tooltool 11:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:18 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 0x107c3bd30>, '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 0x1079a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c33b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:58:18 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 11:58:18 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 11:58:18 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 11:58:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:58:18 INFO - Return code: 0 11:58:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:58:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:58:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:58:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:58:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:58:18 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/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 11:58:18 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/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --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 11:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.skeAxptiIX/Render', 11:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:18 INFO - 'HOME': '/Users/cltbld', 11:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:18 INFO - 'LOGNAME': 'cltbld', 11:58:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:18 INFO - 'MOZ_NO_REMOTE': '1', 11:58:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:18 INFO - 'NO_EM_RESTART': '1', 11:58:18 INFO - 'PAGER': '/bin/cat', 11:58:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:18 INFO - 'PWD': '/builds/slave/test', 11:58:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:18 INFO - 'SHELL': '/bin/bash', 11:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.geA5rIImJh/Listeners', 11:58:18 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 11:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:18 INFO - 'USER': 'cltbld', 11:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:18 INFO - 'XPC_FLAGS': '0x0', 11:58:18 INFO - 'XPC_SERVICE_NAME': '0', 11:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:18 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/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 11:58:18 INFO - mozversion application_buildid: 20160827100114 11:58:18 INFO - mozversion application_changeset: bbbaa584248f10687f5e609c8252c84f5317515c 11:58:18 INFO - mozversion application_display_name: Nightly 11:58:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:58:18 INFO - mozversion application_name: Firefox 11:58:18 INFO - mozversion application_remotingname: firefox 11:58:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:58:18 INFO - mozversion application_vendor: Mozilla 11:58:18 INFO - mozversion application_version: 51.0a1 11:58:18 INFO - mozversion platform_buildid: 20160827100114 11:58:18 INFO - mozversion platform_changeset: bbbaa584248f10687f5e609c8252c84f5317515c 11:58:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:58:18 INFO - mozversion platform_version: 51.0a1 11:58:18 INFO - using testdate: 1472324298 11:58:18 INFO - actual date: 1472324298 11:58:18 INFO - starting webserver on 'localhost:49275' 11:58:18 INFO - SUITE-START | Running 2 tests 11:58:18 INFO - TEST-START | dromaeo_css 11:58:18 INFO - operating with platform_type : mac_ 11:58:18 INFO - Initialising browser for dromaeo_css test... 11:58:18 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpXIL4fm/profile http://localhost:49275/getInfo.html) 11:58:21 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 11:58:21 INFO - PROCESS | 1654 | colorDepth:24 11:58:21 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 11:58:21 INFO - PROCESS | 1654 | __metrics 11:58:21 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 11:58:22 INFO - TEST-INFO | 1654: exit 0 11:58:22 INFO - Browser initialized. 11:58:22 INFO - Running cycle 1/1 for dromaeo_css test... 11:58:22 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpXIL4fm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:34 INFO - PROCESS | 1658 | RSS: Main: 243892224 11:58:34 INFO - PROCESS | 1658 | 11:59:23 INFO - PROCESS | 1658 | 1472324363973 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] 12:01:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 12:01:37 INFO - PROCESS | 1658 | RSS: Main: 262443008 12:01:37 INFO - PROCESS | 1658 | 12:04:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 12:04:40 INFO - PROCESS | 1658 | RSS: Main: 270585856 12:04:40 INFO - PROCESS | 1658 | 12:07:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 12:07:43 INFO - PROCESS | 1658 | RSS: Main: 273244160 12:07:43 INFO - PROCESS | 1658 | 12:10:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 12:10:46 INFO - PROCESS | 1658 | RSS: Main: 268226560 12:10:46 INFO - PROCESS | 1658 | 12:13:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 12:13:49 INFO - PROCESS | 1658 | RSS: Main: 274051072 12:13:49 INFO - PROCESS | 1658 | 12:16:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 12:16:52 INFO - PROCESS | 1658 | RSS: Main: 276852736 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | __start_tp_report 12:16:52 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 12:16:52 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 12:16:52 INFO - PROCESS | 1658 | |i|pagename|runs| 12:16:52 INFO - PROCESS | 1658 | |0;dojo.html;3448.637893021234;3463.7055850252723;3478.3738926993133;3504.2991401719664;3520.700740437063;4603.976980115099;5121.513456221663;5165.147750621148;5826.329972053215;5930.703464826752;5920.496757775594;5933;6001.60989535681;6010.939890601104;6024.2168518092585;4603.953960460402;5285.709285989269;5362.168863826113;5438.700871452069;5483.698396588186;5401.405845357008;5437.945620543804;5477.424870388611;5493.670379777206;5547.223388725582;4087.7751723655188;4427.358033085216;5265.315508983807;5304.522592966651;5332.626716129892;4485.416895803557;5345.09133447311;5347.064263753867;5361.276227709248;5375.731213439312;5258.973705131488;5335.226392173113;5338;5340.54605358545;5341.519263266286;5639.774409023634;5854;5984.8503787405225;5987.161797348374;5998.580099393044;6154.353792851775;6195.694365650454;6198.132261483396;6224.3464436234;6236.656983865885;6238.189035425411;6272.5922815016875;6275;6278.434940855299;6278.4663303619245;5831.3877042910735;5895.29256489224;5981.671008094597;5985.491233245136;6047.334793172748;6366.013267943476;6405.455536279468;6428.742850286029;6432.614043157426;6455;6138.14066030756;6195.101710251988;6217.937820621826;6241.188645476059;6252.874942501125;6140.381550880983;6155.784547540815;6183.196184495987;6215.906761398583;6275.121482992385;6210.813675589739;6212.72042758077;6221.968890155611;6229.626222426669;6239.96880015597;5411.458854114636;6191.783287584913;6241.063840423882;6243.250809902841;6253.37466253371;4865;4970.925436118461;5009.974950125226;5030.4215015272985;5083.415407228142;4486.237339652267;4492.05666809967;4502.4371953505815;4503.7522936238165;4520.073384956077;5954.315253745788;5984.850378740479;6000.069989151689;6059.424354686298;6066;6131.651934473353;6165.290991535941;6184.81445556634;6185.226846644169;6283.5287353448675;5976.84904101686;5988.940110598838;6002.54980876436;6004.969975150097;6065.4541091302;5555.472230138131;5558.277423934944;5586.497215250647;5588.748506317225;5593;6282.308946015934;6412.038194270896;6460.644664543495;6478.4169424752;6592.472602191718;6272.40412160844;6285.1515045470105;6287.088372185916;6300.464460520907;6340.334264902119;6495.382938620824;6527.249366322933;6545.345465453416;6580.276169621242;6583.210014798255;6116.8227554565365;6146.200993870768;6178.536609754196;6194.946859033885;6237.438630523275;6247.812565623039;6252.343503932022;6252.406021427957;6288.717007734755;6312.7159277833525;5247.632665713363;5576.247206627216;6230.813075607739;6297.811065668037;6308.179936608211;5581.860453488695;5889.733707252961;6099.268087829489;6135.44703110649;6144.924638188389;5134.640575159703;6001.819945401645;6013.977623804051;6053.485453736305;6167.84580385476;5505.642133261325;6115.296740874678;6173.41352571505;6177.042558403455;6200.782972595937;5993.220881285405;6089.878202436015;6105;6133.938660613515;6151.231096112986 12:16:52 INFO - PROCESS | 1658 | |1;ext.html;497.55717411503747;502.7159654795042;530.4165418040157;543.2231908371031;581.3575998521636;31671.208219794516;40400.79799601001;40549.3917591236;40608.796956015256;40629.7968510157;35373.823130884375;42147;42493.78753106238;42532.78733606327;42549;9609.231261499064;9804.852927206097;9806.11744942955;9822.852657210147;9892.30753847231;9590.136887680108;9650;9672.854907176397;9676.661316853912;9687.467189304585;9650.75873103171;9676.516174191262;9694.030596940285;9719.07668771469;9723.951380243088;9605.37565058269;9621.711348659552;9637.951810240904;9649.951750241238;9676.12914837668;9747.90252097477;9825.754356141153;9837.704868853945;9843.704688859345;9850.064243896819;40140.79929600363;40372;40506.79746601277;40606.593934060875;40756.18487630231;3493.423585108454;3618.565772107364;3627;3990.06233535119;4063.959360406417;30452.390952181053;30962.690373096208;31151.532727009115;31445.213869653213;31476.527852082007;3208.5828842250357;3332.3168750406353;3347.41420251455;3376.2234686022107;3380.5605271314816;460165;463751;469352;473979.8903016423;474482;58214.70892645595;58406;58473.70763146242;58620.12069818871;58634;61236.693816530635;61320;61532.769344612854;61542;61583;16091.678166436606;16301.021938683716;16343;16350.918245408697;16355.59111022234;12685.93657031709;12748.235105893677;12749;12765.93617031909;12794.744105117845;13401.932990334986;15813.1302778346;16177.676446471005;16242.10668413225;16248.025118492691;5359.097520380287;5431.456854314537;6080.966235739935;6151.9384806151365;6352.745890164434;752.7440670172168;805.1063319715112;961.8794104867891;996.2279233594022;1143.7369405036723;29597.852010739807;30050.849745751133;30296.84851575728;30505.389892202475;31273.374532509224;882.3602887906217;1027.244974943416;1042.2652030318607;1049.2812423489934;1128.7245412683615;15358.616034599001;15395.307211175525;15853.920730396274;15901.284442200129;16016.519504414886;632249;689000;704460;708222;909668;57834.132488012714;58310;58691.70654146702;58763.70618146882;58807;1361.0948719101686;1375.1061809823696;1400.9019368644301;1401.1453013661658;1401.726663300667;27546.586801197598;29136.417271654023;30689.53965690561;31092.48277126292;31404.842975784974;41787.37318940157;47358;49429.75285123551;49747.751261243466;50162.498375015784;482378;587149;587226;587404;591008;25775.484490310464;25851.870740646176;26138.73861261439;26193.73806261913;26604.334891627863;44829.77585112053;45393.09213815771;46331.76834115808;46577.53422465867;46986.76506617445;37781.65510966274;38151.23697525978;38248.42627360648;39026.804865975486;39456.60543394644;37628.435573465875;37762.86711398663;37949.051273718374;38884.805575971935;39082.804585978025;36953.82268028956;37751.62248377481;38089;38463.230735384575;38532.61467385403;30675.693243067282;33957.32085358229;33993.490097648064;34134.65865341315;34164.14589635279;21502.247421340802;24542.754572454047;24953.87523062373;25177.992880285317;25462.23613291604 12:16:52 INFO - PROCESS | 1658 | |2;jquery.html;310.6210423283593;319.7745589359501;371.1334035028209;384.753757595139;401.46605015329595;17729.911350443246;19567.510812229684;20745.06647200876;20839.687404688942;21015;20153.798462015377;20398.592028159426;21081.26215582455;21159.259425920096;21291.57416851662;5968.7612495500125;6098.298695649991;6161.260648722159;6165.475934545569;6213.782517611885;5925.200097986782;5952;6014.548908831834;6058.909116363236;6114.449699527042;5934.525237980973;6042.607230530001;6087.695615219243;6101.115338275948;6113.052476866093;5928.703564821763;6079.300880398722;6084.178635884144;6089.847753806191;6110.022396416574;5181.326427564431;5233.450487698813;5264.341957255343;5292.44429334922;5332.893342133136;26185;26186.476270474483;26277.605835912476;26302;26431;2442.8297597289693;2475.554400207962;2841.2612720692564;3163.1301392117352;3241.692039256267;15180.468683596131;15435.073895566302;15564.37742490299;15653.904226704135;15775.368985240577;1810.248746770089;1850.5373656585853;1854.6847036003912;1880.341880341883;1899.3352326685688;98613.50693246559;112594.43702781516;121480.39259803733;123466;123788;17995.73006404905;19767.110480028434;21518.892405537874;21780.673289900664;21805.90970451471;31071.378572428875;31515.054548363587;34078.14804629854;34735.9579212624;34857.12857178591;10804.783904322027;11161.609343672932;11202.607908723156;11239.60661376848;11318.547258109584;8202.220789025034;8640.049594544595;9077.409968352036;9109.81780364389;9288.024757400512;9546.093121153479;9805.754856128511;9891.961344058915;9985.850212246822;9990.850137247948;3444.7071998880374;3733.1973625670066;3828.674562662205;3962.9405558916637;3999.280129576704;804.2962407893093;823.6869989404108;903.0653273861521;951.7668171298076;1032.9690109296732;18548.721769173473;20768.065437055368;20945.33826321581;21396.679049814265;21501.892490537448;899.5277479323407;960.9525617077419;964.0841200859212;1008.178334657252;1021.6475316015963;10094.646687366054;11295.378754168436;11298.60454884075;11302;11302.604408845651;555829;566353;573014;575799;578180;124367;129676;130230.04654930184;131152;134355.32822335826;973.8441849304219;1035.8135535603665;1050.7635781949152;1051.1958351860833;1057.3867157048894;16266.51200463988;18523.72214416758;18673.439796806117;19900.402987910387;19925.60148797045;41832.3725144117;52704.94590108253;53523.732381337846;54671.17993230184;55226.37283526002;60946.78106437935;74527.25472745203;76438;77289.61355193188;77480.2251977473;8081.959590202011;8111.06722726894;8198;8272.17278272168;8392.20274073962;10378.481075946022;12548.623541293775;12941.54704585335;12962.416691248727;13097.952163827062;10861.45692715377;11171.385573793194;11311.208215424842;11392.316461012366;11464.25482343645;10924.235303528676;11040.227184097035;11120.721981950515;11268.830967535658;11553.942230288794;8972.641094356153;10684.25210235276;11255.380954047607;11437.913398227156;11492;7863.174366691415;8055.476394034369;8090.838183236185;8276.255137037695;8297.875531866906;9349.813003739751;10539.57841686324;11073.50169242402;11222.046126079049;11398.94300528492 12:16:52 INFO - PROCESS | 1658 | |3;mootools.html;1396.497260986045;1470.0811992504684;1679.983609916001;1821.8178182181791;1855.972160417594;6963.512554121214;7155.677994490247;8338.166183381667;8885.15591018853;8896.466212027275;8532.829343413143;8661.870071948926;8662.696805611804;8697.86953195701;8707.651693932236;2356.941076473089;2374.287713685896;2379.4646204603914;2391.6053851114543;2397.137030668958;2357.257463898875;2377.7741114594087;2399.3281881073326;2403.158894386968;2408.614621660535;1779.9765135047335;1998.6802111662137;2256.142665786999;2389.772971567707;2399.3641684953413;2106.9367918962457;2313.9008970738932;2365.077619728307;2367.3726462487452;2372.9762702373014;2323.18688459038;2342.3090188394294;2376.572217000939;2378.2865140457793;2385.8807059646947;8684.305255579538;8710.390272680916;8745;8749.16882896124;8781.297496200288;5212.947870521322;5325.281087053237;5350.438203988603;5368.70472124033;5376;3535.9116022099397;3593.568771747407;3698.4822124902535;3728.664420202195;3743.401055831054;1056.3133962924085;1081.7187531241934;1100.471773548701;1109.6393672056613;1113.5768408004988;11339.659810205707;11422.086233101332;11513.481893314738;11514.827277590843;11548.595799147073;4540.77296135192;4640.419947506562;4792.496787837296;4793.32893394925;4793.520647935178;8370.539620320818;8588.65645374178;9639.325247232766;9793.314467987173;9806.558704858298;4689.95310046902;5291.788328466818;5333.120035194227;5341.038613049611;5359.598030147677;4125.958740412618;4387.583179597933;4854.611631069506;4880.048390563806;4882.462929077798;3825.0628595993603;3872.3223435898603;3938.2714197873483;3965.0880297531153;3969.821358038895;1287.0540152987546;1296.935153242353;1298.6493646715335;1302.8045793131107;1311.4819646239873;750.4934169435609;874.7026011156111;918.6358257986884;923.5290002098843;933.2767105493161;5711.086226203787;5862.530997520188;5958.791442299499;6046.879062418727;6185.690715464209;794.7814351053506;909.6952520905438;926.5737760630186;943.4999450291357;1015.7105225010837;3341.7660763746303;3816.5229346331707;3897.668698160688;3959.1883663848844;4031.9315381423944;10330.793384132276;10603.575856965635;10671.986161314662;10672.30630009047;10680.572777088984;10476.214283928735;10488.947555262175;10650.147988160928;10785.83821242682;10813.513391897384;8073.878891816627;8127.75616731499;8135.633896474555;8174.182581741778;8294.543800091053;4552.362669226245;5754.625949313281;5846.327672317568;5865.736041878211;5941.881162376815;9705.417674939526;9873.25950553697;9910.801783964136;9932;9979.550920208463;9593.520323983634;10006.649767258112;10086.041826026516;10175.389476631426;10219.7445063874;6922.446204303745;7081;7215.134183897966;7383.96308018478;7542.698292068256;8283.37874659391;8374.623141958748;8386;8392.664293428195;8422.989241291085;7331.596762178131;7404.703811847466;7442.776716698508;7492;7530.9246907532415;6329.493640508656;7068.399186069241;7220.025296584894;7221.747238846615;7292.598907059951;6736.427403670743;6849.931500684929;6984.476164287597;7016.7544135954995;7045.753398631024;4953.083679519301;4992.900141997213;5002.324686167321;5028.597712182944;5064.987002599421;4954.033963377107;4994.700317980933;5015.874603134951;5066.06277838601;5363.570914326767 12:16:52 INFO - PROCESS | 1658 | |4;prototype.html;238.8113390421567;275.62514979627707;300.50416812259766;318.11722470145344;319.08900090242344;5441.5102640762325;5654;5791.884162316751;5798.507126894214;5814.738336774844;5009.849704508871;5556.083246264372;5621.341704197262;5688.691600931788;5714.285714285715;4021.2560676274984;4311.827526898928;4340.631046361063;4346.9347959780625;4371.874110011341;3271.3947919634825;3485.7734247273975;4133;4330.372096046071;4334.284843000901;4161.979190104045;4280.186764514732;4282.764447955361;4291.549387314334;4291.635211007068;3576.946345804815;4275.914481710349;4299.8065087070845;4323.913521729579;4342.696011279212;3495;3639.470567955272;3655.141041855162;3663.937458137137;3714.7028237741188;5496.917546236809;5506.80726174586;5535.833924982257;5545.140503222007;5554.805581804618;4902.460729319772;4925.802967881281;4928.33869710356;4937.6049916007;4958.082754690357;5813.244278243844;5876.353601103875;5922.851928701773;5941.584089113764;5968.552358573124;3545.3795585772386;3879.398693202558;4001.9399709004388;4007.699422543321;4032;6098.603590766586;6371.362863713592;6375.649339286338;6378.649174295412;6426.582272152295;3886.1839013806853;4045.838166473367;4061.837526498966;4066.369712694537;4074.266632006208;4135.400366946776;4150.7793330568;4153;4160;4169.332906734908;4182.769947652909;4915.827946021872;4923.433805112458;4940.728259945666;4963.851084467472;5151.047056294523;5747.798827041117;5965.612235204698;6096.420840020191;6119.418655227746;1193.8746431624727;1250.8123781432857;1296.8703129687144;1364.34511434512;1403.1440821099122;746.4811955690743;814.0556953933409;872.2511364713708;942.599395257013;946.5172761891484;4778.709748367991;5110.0801855665595;5158.509941555546;5625.578081643893;5676.205331253628;5238.292830467914;5864.296284445893;5898.852528686817;5941.642971720964;6200.658963757037;5418.864528386822;5539.723013849291;5582.888342233214;5612.887742245132;5689.061304884648;2591.688997320334;2595.9740402596112;2637.4197676511135;2730.945381092367;2757.3244555084134;4781.9043619128115;4802.879928001758;4953.176689287144;4961.5286547777905;5408.45915408456;4900.580239885761;5016.598672106295;5040.521150490697;5381.838544843661;5402.028259685187;4381.16757816014;5052.595792336678;5421.322334708161;5421.9186712200135;5433.212184233343;4569.702969306984;4821.9035619288115;5179.368498922827;5228.869278268074;5292.047431462373;3874.767513949172;4533.342665313577;5110.48895110486;5138.3063286457345;5191.922121168261;4875.536824001714;5085.542301192911;5153.510416510426;5410.702411367255;5424.593155513431;3571;3574.8570057198463;3583.4624806279267;3584.7311451640708;3611.1874828164505;4412.367424053121;4549.909001820011;4909.9018019640125;4941.912779188717;5514.779408823602;5859.94140058594;5989.866991775661;5990.7304171311525;6005.609635373687;6008.759649613967;5082.33929589151;6032.698365081641;6037.516998640011;6038.282772752191;6069.453749162597;5118.456124328095;5750.683712395691;5857;5909.468147866713;5915.633746501434;5394.352677678704;6052.303985041776;6060.333363329942;6076.665783381956;6218.657973811484;5659.660420374791;5690.914636280377;5819.476247137778;5933.584649074523;5950.4000079951 12:16:52 INFO - PROCESS | 1658 | |5;yui.html;681.9147606549182;692.1071817355612;710.8827043537816;753.250515736842;815.6125840225893;11967.521299148035;14859.33133009016;14962.32669529871;15017.624559386008;15162.241887905588;14444.06113602615;14511.346989385476;14612.342444589993;14636.341364638616;14646.267686615653;663.9734410623594;847.1740053447885;873.2882700599023;874.9518776467291;878.0166213840507;846.3948276981956;868.1275318305126;869.678219058949;869.8042940338437;881.1937077574012;919.56320747645;921.0973246218709;921.5852866210232;921.9677311294106;922.9307801914883;915.0803442540238;915.244922938575;915.7161280003154;916.3768637326649;916.5417291354323;656.0389030070969;673.8888083466222;680.8876535371658;681.512718406337;683.6889215406978;14853.331600077914;14991.775123373158;15007.849921500754;15024.09855408679;15078.849211507853;14588.562343129723;14652.41390344385;14671.77992330116;14845.851541484662;14876.70246595062;11823.586174483851;11987.820182697267;12186.634400967985;12200.633980980585;12447.564335248222;3780.867669631577;3798.1074447504816;3971.860984865516;4020.075382662004;4024.4566983457153;118908;120640.79359206471;120930.99999999913;122177;122443.38778306052;9889.714337136127;11270.887291127148;11294.830577541343;11331.32012079278;11547.133964952494;22834.885825570767;22851.88574057119;22860.542789144125;22900.4274893129;22917.968691408925;6944.895826562605;7780.844383112306;7870.016247969004;8027.237412445808;8394;4374.737515749065;4386.1008493258805;4428.335749637516;4452.243118669834;4461.57615026572;3014.6834582368974;3555.2356243407276;3555.4489054196642;3566.375884220251;3575.7318201135017;658.7746790968794;660.9673078445345;661.8709351676376;665.890128128863;670.785877561615;591.1280860730388;623.2271982741458;626.6991843914947;634.4480302137171;641.9582727122722;8855.433926173455;9065.866766654168;10135.341202821794;10332.328398654214;10400;598.2491972574392;632.7724215022841;642.3768944124192;660.6201434175368;663.9668016599151;4068.2800819839936;4072.144849581621;4126.66986641074;4386.18855511725;4391.67062470316;126207;144199;156924;160698;161384.19307903387;98440;107996.46001770099;110320;110706.44646776875;124873.37563312307;94388.52805736064;99033;105029;105946.94053059525;110557;8392.83214335722;8475.957620211859;9625.229981601595;9846.595782880295;10212.693619191436;44248;54217.18674219969;59312.70343648427;59484.26704528557;61654.075188871306;88890;89075;89332;91179.54410227906;91828;13011;13104.082714209913;13133.802992955305;13390.732185356434;13738;14713.33789979475;14719.779203312173;14770.704585908437;14822.85177148258;14886.478973235884;13475.663108422368;13634.590962271148;13683.726325473634;13958.860411395755;14363.994520383472;13439.260840653858;13667.79498307546;13819.516316928859;14055.859441405864;14331.283435828376;12869.872729815348;13469.39387727535;13572.79640805369;13585.313389042567;14018.177636907138;11199.384033878216;11216.943915280372;11471.655850324503;11533.596324128615;11645.88354116448;9431.056894310514;10614.840777388192;10711.94644026775;11553.768924621629;11868.881311187122 12:16:52 INFO - PROCESS | 1658 | __end_tp_report 12:16:52 INFO - PROCESS | 1658 | __start_cc_report 12:16:52 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,376 12:16:52 INFO - PROCESS | 1658 | __end_cc_report 12:16:52 INFO - PROCESS | 1658 | __startTimestamp1472325412251__endTimestamp 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | ------- Summary: start ------- 12:16:52 INFO - PROCESS | 1658 | Number of tests: 6 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5794.84 Median:6053.49 stddev:667.90 (11.0%) stddev-sans-first:644.09 12:16:52 INFO - PROCESS | 1658 | Values: 3448.6 3463.7 3478.4 3504.3 3520.7 4604.0 5121.5 5165.1 5826.3 5930.7 5920.5 5933.0 6001.6 6010.9 6024.2 4604.0 5285.7 5362.2 5438.7 5483.7 5401.4 5437.9 5477.4 5493.7 5547.2 4087.8 4427.4 5265.3 5304.5 5332.6 4485.4 5345.1 5347.1 5361.3 5375.7 5259.0 5335.2 5338.0 5340.5 5341.5 5639.8 5854.0 5984.9 5987.2 5998.6 6154.4 6195.7 6198.1 6224.3 6236.7 6238.2 6272.6 6275.0 6278.4 6278.5 5831.4 5895.3 5981.7 5985.5 6047.3 6366.0 6405.5 6428.7 6432.6 6455.0 6138.1 6195.1 6217.9 6241.2 6252.9 6140.4 6155.8 6183.2 6215.9 6275.1 6210.8 6212.7 6222.0 6229.6 6240.0 5411.5 6191.8 6241.1 6243.3 6253.4 4865.0 4970.9 5010.0 5030.4 5083.4 4486.2 4492.1 4502.4 4503.8 4520.1 5954.3 5984.9 6000.1 6059.4 6066.0 6131.7 6165.3 6184.8 6185.2 6283.5 5976.8 5988.9 6002.5 6005.0 6065.5 5555.5 5558.3 5586.5 5588.7 5593.0 6282.3 6412.0 6460.6 6478.4 6592.5 6272.4 6285.2 6287.1 6300.5 6340.3 6495.4 6527.2 6545.3 6580.3 6583.2 6116.8 6146.2 6178.5 6194.9 6237.4 6247.8 6252.3 6252.4 6288.7 6312.7 5247.6 5576.2 6230.8 6297.8 6308.2 5581.9 5889.7 6099.3 6135.4 6144.9 5134.6 6001.8 6014.0 6053.5 6167.8 5505.6 6115.3 6173.4 6177.0 6200.8 5993.2 6089.9 6105.0 6133.9 6151.2 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:71450.82 Median:40577.99 stddev:161155.10 (397.1%) stddev-sans-first:161519.13 12:16:52 INFO - PROCESS | 1658 | Values: 497.6 502.7 530.4 543.2 581.4 31671.2 40400.8 40549.4 40608.8 40629.8 35373.8 42147.0 42493.8 42532.8 42549.0 9609.2 9804.9 9806.1 9822.9 9892.3 9590.1 9650.0 9672.9 9676.7 9687.5 9650.8 9676.5 9694.0 9719.1 9724.0 9605.4 9621.7 9638.0 9650.0 9676.1 9747.9 9825.8 9837.7 9843.7 9850.1 40140.8 40372.0 40506.8 40606.6 40756.2 3493.4 3618.6 3627.0 3990.1 4064.0 30452.4 30962.7 31151.5 31445.2 31476.5 3208.6 3332.3 3347.4 3376.2 3380.6 460165.0 463751.0 469352.0 473979.9 474482.0 58214.7 58406.0 58473.7 58620.1 58634.0 61236.7 61320.0 61532.8 61542.0 61583.0 16091.7 16301.0 16343.0 16350.9 16355.6 12685.9 12748.2 12749.0 12765.9 12794.7 13401.9 15813.1 16177.7 16242.1 16248.0 5359.1 5431.5 6081.0 6151.9 6352.7 752.7 805.1 961.9 996.2 1143.7 29597.9 30050.8 30296.8 30505.4 31273.4 882.4 1027.2 1042.3 1049.3 1128.7 15358.6 15395.3 15853.9 15901.3 16016.5 632249.0 689000.0 704460.0 708222.0 909668.0 57834.1 58310.0 58691.7 58763.7 58807.0 1361.1 1375.1 1400.9 1401.1 1401.7 27546.6 29136.4 30689.5 31092.5 31404.8 41787.4 47358.0 49429.8 49747.8 50162.5 482378.0 587149.0 587226.0 587404.0 591008.0 25775.5 25851.9 26138.7 26193.7 26604.3 44829.8 45393.1 46331.8 46577.5 46986.8 37781.7 38151.2 38248.4 39026.8 39456.6 37628.4 37762.9 37949.1 38884.8 39082.8 36953.8 37751.6 38089.0 38463.2 38532.6 30675.7 33957.3 33993.5 34134.7 34164.1 21502.2 24542.8 24953.9 25178.0 25462.2 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35311.40 Median:14636.13 stddev:95119.84 (649.9%) stddev-sans-first:95350.37 12:16:52 INFO - PROCESS | 1658 | Values: 310.6 319.8 371.1 384.8 401.5 17729.9 19567.5 20745.1 20839.7 21015.0 20153.8 20398.6 21081.3 21159.3 21291.6 5968.8 6098.3 6161.3 6165.5 6213.8 5925.2 5952.0 6014.5 6058.9 6114.4 5934.5 6042.6 6087.7 6101.1 6113.1 5928.7 6079.3 6084.2 6089.8 6110.0 5181.3 5233.5 5264.3 5292.4 5332.9 26185.0 26186.5 26277.6 26302.0 26431.0 2442.8 2475.6 2841.3 3163.1 3241.7 15180.5 15435.1 15564.4 15653.9 15775.4 1810.2 1850.5 1854.7 1880.3 1899.3 98613.5 112594.4 121480.4 123466.0 123788.0 17995.7 19767.1 21518.9 21780.7 21805.9 31071.4 31515.1 34078.1 34736.0 34857.1 10804.8 11161.6 11202.6 11239.6 11318.5 8202.2 8640.0 9077.4 9109.8 9288.0 9546.1 9805.8 9892.0 9985.9 9990.9 3444.7 3733.2 3828.7 3962.9 3999.3 804.3 823.7 903.1 951.8 1033.0 18548.7 20768.1 20945.3 21396.7 21501.9 899.5 961.0 964.1 1008.2 1021.6 10094.6 11295.4 11298.6 11302.0 11302.6 555829.0 566353.0 573014.0 575799.0 578180.0 124367.0 129676.0 130230.0 131152.0 134355.3 973.8 1035.8 1050.8 1051.2 1057.4 16266.5 18523.7 18673.4 19900.4 19925.6 41832.4 52704.9 53523.7 54671.2 55226.4 60946.8 74527.3 76438.0 77289.6 77480.2 8082.0 8111.1 8198.0 8272.2 8392.2 10378.5 12548.6 12941.5 12962.4 13098.0 10861.5 11171.4 11311.2 11392.3 11464.3 10924.2 11040.2 11120.7 11268.8 11553.9 8972.6 10684.3 11255.4 11437.9 11492.0 7863.2 8055.5 8090.8 8276.3 8297.9 9349.8 10539.6 11073.5 11222.0 11398.9 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5631.89 Median:4998.51 stddev:3136.17 (62.7%) stddev-sans-first:3128.81 12:16:52 INFO - PROCESS | 1658 | Values: 1396.5 1470.1 1680.0 1821.8 1856.0 6963.5 7155.7 8338.2 8885.2 8896.5 8532.8 8661.9 8662.7 8697.9 8707.7 2356.9 2374.3 2379.5 2391.6 2397.1 2357.3 2377.8 2399.3 2403.2 2408.6 1780.0 1998.7 2256.1 2389.8 2399.4 2106.9 2313.9 2365.1 2367.4 2373.0 2323.2 2342.3 2376.6 2378.3 2385.9 8684.3 8710.4 8745.0 8749.2 8781.3 5212.9 5325.3 5350.4 5368.7 5376.0 3535.9 3593.6 3698.5 3728.7 3743.4 1056.3 1081.7 1100.5 1109.6 1113.6 11339.7 11422.1 11513.5 11514.8 11548.6 4540.8 4640.4 4792.5 4793.3 4793.5 8370.5 8588.7 9639.3 9793.3 9806.6 4690.0 5291.8 5333.1 5341.0 5359.6 4126.0 4387.6 4854.6 4880.0 4882.5 3825.1 3872.3 3938.3 3965.1 3969.8 1287.1 1296.9 1298.6 1302.8 1311.5 750.5 874.7 918.6 923.5 933.3 5711.1 5862.5 5958.8 6046.9 6185.7 794.8 909.7 926.6 943.5 1015.7 3341.8 3816.5 3897.7 3959.2 4031.9 10330.8 10603.6 10672.0 10672.3 10680.6 10476.2 10488.9 10650.1 10785.8 10813.5 8073.9 8127.8 8135.6 8174.2 8294.5 4552.4 5754.6 5846.3 5865.7 5941.9 9705.4 9873.3 9910.8 9932.0 9979.6 9593.5 10006.6 10086.0 10175.4 10219.7 6922.4 7081.0 7215.1 7384.0 7542.7 8283.4 8374.6 8386.0 8392.7 8423.0 7331.6 7404.7 7442.8 7492.0 7530.9 6329.5 7068.4 7220.0 7221.7 7292.6 6736.4 6849.9 6984.5 7016.8 7045.8 4953.1 4992.9 5002.3 5028.6 5065.0 4954.0 4994.7 5015.9 5066.1 5363.6 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4628.53 Median:5083.94 stddev:1442.84 (28.4%) stddev-sans-first:1408.77 12:16:52 INFO - PROCESS | 1658 | Values: 238.8 275.6 300.5 318.1 319.1 5441.5 5654.0 5791.9 5798.5 5814.7 5009.8 5556.1 5621.3 5688.7 5714.3 4021.3 4311.8 4340.6 4346.9 4371.9 3271.4 3485.8 4133.0 4330.4 4334.3 4162.0 4280.2 4282.8 4291.5 4291.6 3576.9 4275.9 4299.8 4323.9 4342.7 3495.0 3639.5 3655.1 3663.9 3714.7 5496.9 5506.8 5535.8 5545.1 5554.8 4902.5 4925.8 4928.3 4937.6 4958.1 5813.2 5876.4 5922.9 5941.6 5968.6 3545.4 3879.4 4001.9 4007.7 4032.0 6098.6 6371.4 6375.6 6378.6 6426.6 3886.2 4045.8 4061.8 4066.4 4074.3 4135.4 4150.8 4153.0 4160.0 4169.3 4182.8 4915.8 4923.4 4940.7 4963.9 5151.0 5747.8 5965.6 6096.4 6119.4 1193.9 1250.8 1296.9 1364.3 1403.1 746.5 814.1 872.3 942.6 946.5 4778.7 5110.1 5158.5 5625.6 5676.2 5238.3 5864.3 5898.9 5941.6 6200.7 5418.9 5539.7 5582.9 5612.9 5689.1 2591.7 2596.0 2637.4 2730.9 2757.3 4781.9 4802.9 4953.2 4961.5 5408.5 4900.6 5016.6 5040.5 5381.8 5402.0 4381.2 5052.6 5421.3 5421.9 5433.2 4569.7 4821.9 5179.4 5228.9 5292.0 3874.8 4533.3 5110.5 5138.3 5191.9 4875.5 5085.5 5153.5 5410.7 5424.6 3571.0 3574.9 3583.5 3584.7 3611.2 4412.4 4549.9 4909.9 4941.9 5514.8 5859.9 5989.9 5990.7 6005.6 6008.8 5082.3 6032.7 6037.5 6038.3 6069.5 5118.5 5750.7 5857.0 5909.5 5915.6 5394.4 6052.3 6060.3 6076.7 6218.7 5659.7 5690.9 5819.5 5933.6 5950.4 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24338.65 Median:3555.34 stddev:38593.05 (1085.5%) stddev-sans-first:38660.44 12:16:52 INFO - PROCESS | 1658 | Values: 681.9 692.1 710.9 753.3 815.6 11967.5 14859.3 14962.3 15017.6 15162.2 14444.1 14511.3 14612.3 14636.3 14646.3 664.0 847.2 873.3 875.0 878.0 846.4 868.1 869.7 869.8 881.2 919.6 921.1 921.6 922.0 922.9 915.1 915.2 915.7 916.4 916.5 656.0 673.9 680.9 681.5 683.7 14853.3 14991.8 15007.8 15024.1 15078.8 14588.6 14652.4 14671.8 14845.9 14876.7 11823.6 11987.8 12186.6 12200.6 12447.6 3780.9 3798.1 3971.9 4020.1 4024.5 118908.0 120640.8 120931.0 122177.0 122443.4 9889.7 11270.9 11294.8 11331.3 11547.1 22834.9 22851.9 22860.5 22900.4 22918.0 6944.9 7780.8 7870.0 8027.2 8394.0 4374.7 4386.1 4428.3 4452.2 4461.6 3014.7 3555.2 3555.4 3566.4 3575.7 658.8 661.0 661.9 665.9 670.8 591.1 623.2 626.7 634.4 642.0 8855.4 9065.9 10135.3 10332.3 10400.0 598.2 632.8 642.4 660.6 664.0 4068.3 4072.1 4126.7 4386.2 4391.7 126207.0 144199.0 156924.0 160698.0 161384.2 98440.0 107996.5 110320.0 110706.4 124873.4 94388.5 99033.0 105029.0 105946.9 110557.0 8392.8 8476.0 9625.2 9846.6 10212.7 44248.0 54217.2 59312.7 59484.3 61654.1 88890.0 89075.0 89332.0 91179.5 91828.0 13011.0 13104.1 13133.8 13390.7 13738.0 14713.3 14719.8 14770.7 14822.9 14886.5 13475.7 13634.6 13683.7 13958.9 14364.0 13439.3 13667.8 13819.5 14055.9 14331.3 12869.9 13469.4 13572.8 13585.3 14018.2 11199.4 11216.9 11471.7 11533.6 11645.9 9431.1 10614.8 10711.9 11553.8 11868.9 12:16:52 INFO - PROCESS | 1658 | -------- Summary: end -------- 12:16:52 INFO - PROCESS | 1658 | 12:16:52 INFO - TEST-INFO | 1658: exit 0 12:16:52 INFO - TEST-OK | dromaeo_css | took 1114293ms 12:16:52 INFO - TEST-START | kraken 12:16:52 INFO - operating with platform_type : mac_ 12:16:52 INFO - Initialising browser for kraken test... 12:16:52 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpueWLCZ/profile http://localhost:49275/getInfo.html) 12:16:55 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 12:16:55 INFO - PROCESS | 1666 | colorDepth:24 12:16:55 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 12:16:55 INFO - PROCESS | 1666 | __metrics 12:16:55 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:16:56 INFO - TEST-INFO | 1666: exit 0 12:16:56 INFO - Browser initialized. 12:16:56 INFO - Running cycle 1/1 for kraken test... 12:16:56 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpueWLCZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:08 INFO - PROCESS | 1668 | RSS: Main: 243855360 12:17:08 INFO - PROCESS | 1668 | 12:17:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:12 INFO - PROCESS | 1668 | RSS: Main: 257044480 12:17:12 INFO - PROCESS | 1668 | 12:17:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 12:17:15 INFO - PROCESS | 1668 | RSS: Main: 265682944 12:17:15 INFO - PROCESS | 1668 | 12:17:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 12:17:19 INFO - PROCESS | 1668 | RSS: Main: 264146944 12:17:19 INFO - PROCESS | 1668 | 12:17:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 12:17:21 INFO - PROCESS | 1668 | RSS: Main: 265625600 12:17:21 INFO - PROCESS | 1668 | 12:17:23 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:24 INFO - PROCESS | 1668 | RSS: Main: 265805824 12:17:24 INFO - PROCESS | 1668 | 12:17:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:28 INFO - PROCESS | 1668 | RSS: Main: 266616832 12:17:28 INFO - PROCESS | 1668 | 12:17:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 12:17:31 INFO - PROCESS | 1668 | RSS: Main: 266776576 12:17:31 INFO - PROCESS | 1668 | 12:17:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 12:17:35 INFO - PROCESS | 1668 | RSS: Main: 267014144 12:17:35 INFO - PROCESS | 1668 | 12:17:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:17:37 INFO - PROCESS | 1668 | RSS: Main: 267804672 12:17:37 INFO - PROCESS | 1668 | 12:17:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:17:40 INFO - PROCESS | 1668 | RSS: Main: 267558912 12:17:40 INFO - PROCESS | 1668 | 12:17:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:17:43 INFO - PROCESS | 1668 | RSS: Main: 267898880 12:17:43 INFO - PROCESS | 1668 | 12:17:46 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:17:46 INFO - PROCESS | 1668 | RSS: Main: 268156928 12:17:46 INFO - PROCESS | 1668 | 12:17:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:17:50 INFO - PROCESS | 1668 | RSS: Main: 268222464 12:17:50 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 12:17:52 INFO - PROCESS | 1668 | RSS: Main: 270295040 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | __start_tp_report 12:17:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 12:17:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 12:17:52 INFO - PROCESS | 1668 | |i|pagename|runs| 12:17:52 INFO - PROCESS | 1668 | |0;ai-astar;116;130;166;155;117;101;118;116;117;118 12:17:52 INFO - PROCESS | 1668 | |1;audio-beat-detection;142;109;136;159;108;132;127;110;158;113 12:17:52 INFO - PROCESS | 1668 | |2;audio-dft;177;247;274;235;197;196;202;199;188;175 12:17:52 INFO - PROCESS | 1668 | |3;audio-fft;63;108;110;148;59;58;58;64;136;59 12:17:52 INFO - PROCESS | 1668 | |4;audio-oscillator;70;72;128;77;77;69;105;56;93;143 12:17:52 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;85;74;78;115;132;122;93;88;91;78 12:17:52 INFO - PROCESS | 1668 | |6;imaging-darkroom;126;123;97;149;91;151;103;148;135;96 12:17:52 INFO - PROCESS | 1668 | |7;imaging-desaturate;79;148;142;92;93;92;93;90;93;103 12:17:52 INFO - PROCESS | 1668 | |8;json-parse-financial;56;59;57;58;58;59;58;57;58;57 12:17:52 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;68;72;72;72;79;78;80;73;71;72 12:17:52 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;90;90;106;106;81;89;86;104;104;107 12:17:52 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;140;141;152;149;151;151;152;179;195;151 12:17:52 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;171;175;174;187;230;170;182;169;170;172 12:17:52 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;67;68;85;76;68;69;68;66;67;69 12:17:52 INFO - PROCESS | 1668 | __end_tp_report 12:17:52 INFO - PROCESS | 1668 | __start_cc_report 12:17:52 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,934 12:17:52 INFO - PROCESS | 1668 | __end_cc_report 12:17:52 INFO - PROCESS | 1668 | __startTimestamp1472325472439__endTimestamp 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | ------- Summary: start ------- 12:17:52 INFO - PROCESS | 1668 | Number of tests: 14 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:125.40 Median:118.00 stddev:19.91 (16.9%) stddev-sans-first:20.83 12:17:52 INFO - PROCESS | 1668 | Values: 116.0 130.0 166.0 155.0 117.0 101.0 118.0 116.0 117.0 118.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:134.00 stddev:19.52 (14.6%) stddev-sans-first:20.16 12:17:52 INFO - PROCESS | 1668 | Values: 142.0 109.0 136.0 159.0 108.0 132.0 127.0 110.0 158.0 113.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:209.00 Median:200.50 stddev:32.37 (16.1%) stddev-sans-first:32.19 12:17:52 INFO - PROCESS | 1668 | Values: 177.0 247.0 274.0 235.0 197.0 196.0 202.0 199.0 188.0 175.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:86.30 Median:58.50 stddev:35.66 (61.0%) stddev-sans-first:36.81 12:17:52 INFO - PROCESS | 1668 | Values: 63.0 108.0 110.0 148.0 59.0 58.0 58.0 64.0 136.0 59.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:71.00 stddev:28.16 (39.7%) stddev-sans-first:29.01 12:17:52 INFO - PROCESS | 1668 | Values: 70.0 72.0 128.0 77.0 77.0 69.0 105.0 56.0 93.0 143.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:81.50 stddev:20.23 (24.8%) stddev-sans-first:21.09 12:17:52 INFO - PROCESS | 1668 | Values: 85.0 74.0 78.0 115.0 132.0 122.0 93.0 88.0 91.0 78.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:121.90 Median:150.00 stddev:23.70 (15.8%) stddev-sans-first:25.09 12:17:52 INFO - PROCESS | 1668 | Values: 126.0 123.0 97.0 149.0 91.0 151.0 103.0 148.0 135.0 96.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:102.50 Median:92.00 stddev:23.17 (25.2%) stddev-sans-first:22.96 12:17:52 INFO - PROCESS | 1668 | Values: 79.0 148.0 142.0 92.0 93.0 92.0 93.0 90.0 93.0 103.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:0.95 (1.6%) stddev-sans-first:0.78 12:17:52 INFO - PROCESS | 1668 | Values: 56.0 59.0 57.0 58.0 58.0 59.0 58.0 57.0 58.0 57.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:72.50 stddev:3.92 (5.4%) stddev-sans-first:3.57 12:17:52 INFO - PROCESS | 1668 | Values: 68.0 72.0 72.0 72.0 79.0 78.0 80.0 73.0 71.0 72.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:96.30 Median:83.50 stddev:9.97 (11.9%) stddev-sans-first:10.31 12:17:52 INFO - PROCESS | 1668 | Values: 90.0 90.0 106.0 106.0 81.0 89.0 86.0 104.0 104.0 107.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:151.50 stddev:17.28 (11.4%) stddev-sans-first:17.32 12:17:52 INFO - PROCESS | 1668 | Values: 140.0 141.0 152.0 149.0 151.0 151.0 152.0 179.0 195.0 151.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:174.50 stddev:18.50 (10.6%) stddev-sans-first:19.33 12:17:52 INFO - PROCESS | 1668 | Values: 171.0 175.0 174.0 187.0 230.0 170.0 182.0 169.0 170.0 172.0 12:17:52 INFO - PROCESS | 1668 | 12:17:52 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:68.50 stddev:5.85 (8.5%) stddev-sans-first:6.08 12:17:52 INFO - PROCESS | 1668 | Values: 67.0 68.0 85.0 76.0 68.0 69.0 68.0 66.0 67.0 69.0 12:17:52 INFO - PROCESS | 1668 | -------- Summary: end -------- 12:17:52 INFO - PROCESS | 1668 | 12:17:53 INFO - TEST-INFO | 1668: exit 0 12:17:53 INFO - TEST-OK | kraken | took 60370ms 12:17:53 INFO - SUITE-END | took 1174s 12:17:53 INFO - Completed test suite (00:19:35) 12:17:53 INFO - javascript benchmark 12:17:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7498.040234858095, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3448.637893021234, 3463.7055850252723, 3478.3738926993133, 3504.2991401719664, 3520.700740437063, 4603.976980115099, 5121.513456221663, 5165.147750621148, 5826.329972053215, 5930.703464826752, 5920.496757775594, 5933.0, 6001.60989535681, 6010.939890601104, 6024.2168518092585, 4603.953960460402, 5285.709285989269, 5362.168863826113, 5438.700871452069, 5483.698396588186, 5401.405845357008, 5437.945620543804, 5477.424870388611, 5493.670379777206, 5547.223388725582, 4087.7751723655188, 4427.358033085216, 5265.315508983807, 5304.522592966651, 5332.626716129892, 4485.416895803557, 5345.09133447311, 5347.064263753867, 5361.276227709248, 5375.731213439312, 5258.973705131488, 5335.226392173113, 5338.0, 5340.54605358545, 5341.519263266286, 5639.774409023634, 5854.0, 5984.8503787405225, 5987.161797348374, 5998.580099393044, 6154.353792851775, 6195.694365650454, 6198.132261483396, 6224.3464436234, 6236.656983865885, 6238.189035425411, 6272.5922815016875, 6275.0, 6278.434940855299, 6278.4663303619245, 5831.3877042910735, 5895.29256489224, 5981.671008094597, 5985.491233245136, 6047.334793172748, 6366.013267943476, 6405.455536279468, 6428.742850286029, 6432.614043157426, 6455.0, 6138.14066030756, 6195.101710251988, 6217.937820621826, 6241.188645476059, 6252.874942501125, 6140.381550880983, 6155.784547540815, 6183.196184495987, 6215.906761398583, 6275.121482992385, 6210.813675589739, 6212.72042758077, 6221.968890155611, 6229.626222426669, 6239.96880015597, 5411.458854114636, 6191.783287584913, 6241.063840423882, 6243.250809902841, 6253.37466253371, 4865.0, 4970.925436118461, 5009.974950125226, 5030.4215015272985, 5083.415407228142, 4486.237339652267, 4492.05666809967, 4502.4371953505815, 4503.7522936238165, 4520.073384956077, 5954.315253745788, 5984.850378740479, 6000.069989151689, 6059.424354686298, 6066.0, 6131.651934473353, 6165.290991535941, 6184.81445556634, 6185.226846644169, 6283.5287353448675, 5976.84904101686, 5988.940110598838, 6002.54980876436, 6004.969975150097, 6065.4541091302, 5555.472230138131, 5558.277423934944, 5586.497215250647, 5588.748506317225, 5593.0, 6282.308946015934, 6412.038194270896, 6460.644664543495, 6478.4169424752, 6592.472602191718, 6272.40412160844, 6285.1515045470105, 6287.088372185916, 6300.464460520907, 6340.334264902119, 6495.382938620824, 6527.249366322933, 6545.345465453416, 6580.276169621242, 6583.210014798255, 6116.8227554565365, 6146.200993870768, 6178.536609754196, 6194.946859033885, 6237.438630523275, 6247.812565623039, 6252.343503932022, 6252.406021427957, 6288.717007734755, 6312.7159277833525, 5247.632665713363, 5576.247206627216, 6230.813075607739, 6297.811065668037, 6308.179936608211, 5581.860453488695, 5889.733707252961, 6099.268087829489, 6135.44703110649, 6144.924638188389, 5134.640575159703, 6001.819945401645, 6013.977623804051, 6053.485453736305, 6167.84580385476, 5505.642133261325, 6115.296740874678, 6173.41352571505, 6177.042558403455, 6200.782972595937, 5993.220881285405, 6089.878202436015, 6105.0, 6133.938660613515, 6151.231096112986], "value": 5754.007865058606, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.55717411503747, 502.7159654795042, 530.4165418040157, 543.2231908371031, 581.3575998521636, 31671.208219794516, 40400.79799601001, 40549.3917591236, 40608.796956015256, 40629.7968510157, 35373.823130884375, 42147.0, 42493.78753106238, 42532.78733606327, 42549.0, 9609.231261499064, 9804.852927206097, 9806.11744942955, 9822.852657210147, 9892.30753847231, 9590.136887680108, 9650.0, 9672.854907176397, 9676.661316853912, 9687.467189304585, 9650.75873103171, 9676.516174191262, 9694.030596940285, 9719.07668771469, 9723.951380243088, 9605.37565058269, 9621.711348659552, 9637.951810240904, 9649.951750241238, 9676.12914837668, 9747.90252097477, 9825.754356141153, 9837.704868853945, 9843.704688859345, 9850.064243896819, 40140.79929600363, 40372.0, 40506.79746601277, 40606.593934060875, 40756.18487630231, 3493.423585108454, 3618.565772107364, 3627.0, 3990.06233535119, 4063.959360406417, 30452.390952181053, 30962.690373096208, 31151.532727009115, 31445.213869653213, 31476.527852082007, 3208.5828842250357, 3332.3168750406353, 3347.41420251455, 3376.2234686022107, 3380.5605271314816, 460165.0, 463751.0, 469352.0, 473979.8903016423, 474482.0, 58214.70892645595, 58406.0, 58473.70763146242, 58620.12069818871, 58634.0, 61236.693816530635, 61320.0, 61532.769344612854, 61542.0, 61583.0, 16091.678166436606, 16301.021938683716, 16343.0, 16350.918245408697, 16355.59111022234, 12685.93657031709, 12748.235105893677, 12749.0, 12765.93617031909, 12794.744105117845, 13401.932990334986, 15813.1302778346, 16177.676446471005, 16242.10668413225, 16248.025118492691, 5359.097520380287, 5431.456854314537, 6080.966235739935, 6151.9384806151365, 6352.745890164434, 752.7440670172168, 805.1063319715112, 961.8794104867891, 996.2279233594022, 1143.7369405036723, 29597.852010739807, 30050.849745751133, 30296.84851575728, 30505.389892202475, 31273.374532509224, 882.3602887906217, 1027.244974943416, 1042.2652030318607, 1049.2812423489934, 1128.7245412683615, 15358.616034599001, 15395.307211175525, 15853.920730396274, 15901.284442200129, 16016.519504414886, 632249.0, 689000.0, 704460.0, 708222.0, 909668.0, 57834.132488012714, 58310.0, 58691.70654146702, 58763.70618146882, 58807.0, 1361.0948719101686, 1375.1061809823696, 1400.9019368644301, 1401.1453013661658, 1401.726663300667, 27546.586801197598, 29136.417271654023, 30689.53965690561, 31092.48277126292, 31404.842975784974, 41787.37318940157, 47358.0, 49429.75285123551, 49747.751261243466, 50162.498375015784, 482378.0, 587149.0, 587226.0, 587404.0, 591008.0, 25775.484490310464, 25851.870740646176, 26138.73861261439, 26193.73806261913, 26604.334891627863, 44829.77585112053, 45393.09213815771, 46331.76834115808, 46577.53422465867, 46986.76506617445, 37781.65510966274, 38151.23697525978, 38248.42627360648, 39026.804865975486, 39456.60543394644, 37628.435573465875, 37762.86711398663, 37949.051273718374, 38884.805575971935, 39082.804585978025, 36953.82268028956, 37751.62248377481, 38089.0, 38463.230735384575, 38532.61467385403, 30675.693243067282, 33957.32085358229, 33993.490097648064, 34134.65865341315, 34164.14589635279, 21502.247421340802, 24542.754572454047, 24953.87523062373, 25177.992880285317, 25462.23613291604], "value": 19756.678844562728, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.6210423283593, 319.7745589359501, 371.1334035028209, 384.753757595139, 401.46605015329595, 17729.911350443246, 19567.510812229684, 20745.06647200876, 20839.687404688942, 21015.0, 20153.798462015377, 20398.592028159426, 21081.26215582455, 21159.259425920096, 21291.57416851662, 5968.7612495500125, 6098.298695649991, 6161.260648722159, 6165.475934545569, 6213.782517611885, 5925.200097986782, 5952.0, 6014.548908831834, 6058.909116363236, 6114.449699527042, 5934.525237980973, 6042.607230530001, 6087.695615219243, 6101.115338275948, 6113.052476866093, 5928.703564821763, 6079.300880398722, 6084.178635884144, 6089.847753806191, 6110.022396416574, 5181.326427564431, 5233.450487698813, 5264.341957255343, 5292.44429334922, 5332.893342133136, 26185.0, 26186.476270474483, 26277.605835912476, 26302.0, 26431.0, 2442.8297597289693, 2475.554400207962, 2841.2612720692564, 3163.1301392117352, 3241.692039256267, 15180.468683596131, 15435.073895566302, 15564.37742490299, 15653.904226704135, 15775.368985240577, 1810.248746770089, 1850.5373656585853, 1854.6847036003912, 1880.341880341883, 1899.3352326685688, 98613.50693246559, 112594.43702781516, 121480.39259803733, 123466.0, 123788.0, 17995.73006404905, 19767.110480028434, 21518.892405537874, 21780.673289900664, 21805.90970451471, 31071.378572428875, 31515.054548363587, 34078.14804629854, 34735.9579212624, 34857.12857178591, 10804.783904322027, 11161.609343672932, 11202.607908723156, 11239.60661376848, 11318.547258109584, 8202.220789025034, 8640.049594544595, 9077.409968352036, 9109.81780364389, 9288.024757400512, 9546.093121153479, 9805.754856128511, 9891.961344058915, 9985.850212246822, 9990.850137247948, 3444.7071998880374, 3733.1973625670066, 3828.674562662205, 3962.9405558916637, 3999.280129576704, 804.2962407893093, 823.6869989404108, 903.0653273861521, 951.7668171298076, 1032.9690109296732, 18548.721769173473, 20768.065437055368, 20945.33826321581, 21396.679049814265, 21501.892490537448, 899.5277479323407, 960.9525617077419, 964.0841200859212, 1008.178334657252, 1021.6475316015963, 10094.646687366054, 11295.378754168436, 11298.60454884075, 11302.0, 11302.604408845651, 555829.0, 566353.0, 573014.0, 575799.0, 578180.0, 124367.0, 129676.0, 130230.04654930184, 131152.0, 134355.32822335826, 973.8441849304219, 1035.8135535603665, 1050.7635781949152, 1051.1958351860833, 1057.3867157048894, 16266.51200463988, 18523.72214416758, 18673.439796806117, 19900.402987910387, 19925.60148797045, 41832.3725144117, 52704.94590108253, 53523.732381337846, 54671.17993230184, 55226.37283526002, 60946.78106437935, 74527.25472745203, 76438.0, 77289.61355193188, 77480.2251977473, 8081.959590202011, 8111.06722726894, 8198.0, 8272.17278272168, 8392.20274073962, 10378.481075946022, 12548.623541293775, 12941.54704585335, 12962.416691248727, 13097.952163827062, 10861.45692715377, 11171.385573793194, 11311.208215424842, 11392.316461012366, 11464.25482343645, 10924.235303528676, 11040.227184097035, 11120.721981950515, 11268.830967535658, 11553.942230288794, 8972.641094356153, 10684.25210235276, 11255.380954047607, 11437.913398227156, 11492.0, 7863.174366691415, 8055.476394034369, 8090.838183236185, 8276.255137037695, 8297.875531866906, 9349.813003739751, 10539.57841686324, 11073.50169242402, 11222.046126079049, 11398.94300528492], "value": 10617.71833733929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.497260986045, 1470.0811992504684, 1679.983609916001, 1821.8178182181791, 1855.972160417594, 6963.512554121214, 7155.677994490247, 8338.166183381667, 8885.15591018853, 8896.466212027275, 8532.829343413143, 8661.870071948926, 8662.696805611804, 8697.86953195701, 8707.651693932236, 2356.941076473089, 2374.287713685896, 2379.4646204603914, 2391.6053851114543, 2397.137030668958, 2357.257463898875, 2377.7741114594087, 2399.3281881073326, 2403.158894386968, 2408.614621660535, 1779.9765135047335, 1998.6802111662137, 2256.142665786999, 2389.772971567707, 2399.3641684953413, 2106.9367918962457, 2313.9008970738932, 2365.077619728307, 2367.3726462487452, 2372.9762702373014, 2323.18688459038, 2342.3090188394294, 2376.572217000939, 2378.2865140457793, 2385.8807059646947, 8684.305255579538, 8710.390272680916, 8745.0, 8749.16882896124, 8781.297496200288, 5212.947870521322, 5325.281087053237, 5350.438203988603, 5368.70472124033, 5376.0, 3535.9116022099397, 3593.568771747407, 3698.4822124902535, 3728.664420202195, 3743.401055831054, 1056.3133962924085, 1081.7187531241934, 1100.471773548701, 1109.6393672056613, 1113.5768408004988, 11339.659810205707, 11422.086233101332, 11513.481893314738, 11514.827277590843, 11548.595799147073, 4540.77296135192, 4640.419947506562, 4792.496787837296, 4793.32893394925, 4793.520647935178, 8370.539620320818, 8588.65645374178, 9639.325247232766, 9793.314467987173, 9806.558704858298, 4689.95310046902, 5291.788328466818, 5333.120035194227, 5341.038613049611, 5359.598030147677, 4125.958740412618, 4387.583179597933, 4854.611631069506, 4880.048390563806, 4882.462929077798, 3825.0628595993603, 3872.3223435898603, 3938.2714197873483, 3965.0880297531153, 3969.821358038895, 1287.0540152987546, 1296.935153242353, 1298.6493646715335, 1302.8045793131107, 1311.4819646239873, 750.4934169435609, 874.7026011156111, 918.6358257986884, 923.5290002098843, 933.2767105493161, 5711.086226203787, 5862.530997520188, 5958.791442299499, 6046.879062418727, 6185.690715464209, 794.7814351053506, 909.6952520905438, 926.5737760630186, 943.4999450291357, 1015.7105225010837, 3341.7660763746303, 3816.5229346331707, 3897.668698160688, 3959.1883663848844, 4031.9315381423944, 10330.793384132276, 10603.575856965635, 10671.986161314662, 10672.30630009047, 10680.572777088984, 10476.214283928735, 10488.947555262175, 10650.147988160928, 10785.83821242682, 10813.513391897384, 8073.878891816627, 8127.75616731499, 8135.633896474555, 8174.182581741778, 8294.543800091053, 4552.362669226245, 5754.625949313281, 5846.327672317568, 5865.736041878211, 5941.881162376815, 9705.417674939526, 9873.25950553697, 9910.801783964136, 9932.0, 9979.550920208463, 9593.520323983634, 10006.649767258112, 10086.041826026516, 10175.389476631426, 10219.7445063874, 6922.446204303745, 7081.0, 7215.134183897966, 7383.96308018478, 7542.698292068256, 8283.37874659391, 8374.623141958748, 8386.0, 8392.664293428195, 8422.989241291085, 7331.596762178131, 7404.703811847466, 7442.776716698508, 7492.0, 7530.9246907532415, 6329.493640508656, 7068.399186069241, 7220.025296584894, 7221.747238846615, 7292.598907059951, 6736.427403670743, 6849.931500684929, 6984.476164287597, 7016.7544135954995, 7045.753398631024, 4953.083679519301, 4992.900141997213, 5002.324686167321, 5028.597712182944, 5064.987002599421, 4954.033963377107, 4994.700317980933, 5015.874603134951, 5066.06277838601, 5363.570914326767], "value": 4541.175794957044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [238.8113390421567, 275.62514979627707, 300.50416812259766, 318.11722470145344, 319.08900090242344, 5441.5102640762325, 5654.0, 5791.884162316751, 5798.507126894214, 5814.738336774844, 5009.849704508871, 5556.083246264372, 5621.341704197262, 5688.691600931788, 5714.285714285715, 4021.2560676274984, 4311.827526898928, 4340.631046361063, 4346.9347959780625, 4371.874110011341, 3271.3947919634825, 3485.7734247273975, 4133.0, 4330.372096046071, 4334.284843000901, 4161.979190104045, 4280.186764514732, 4282.764447955361, 4291.549387314334, 4291.635211007068, 3576.946345804815, 4275.914481710349, 4299.8065087070845, 4323.913521729579, 4342.696011279212, 3495.0, 3639.470567955272, 3655.141041855162, 3663.937458137137, 3714.7028237741188, 5496.917546236809, 5506.80726174586, 5535.833924982257, 5545.140503222007, 5554.805581804618, 4902.460729319772, 4925.802967881281, 4928.33869710356, 4937.6049916007, 4958.082754690357, 5813.244278243844, 5876.353601103875, 5922.851928701773, 5941.584089113764, 5968.552358573124, 3545.3795585772386, 3879.398693202558, 4001.9399709004388, 4007.699422543321, 4032.0, 6098.603590766586, 6371.362863713592, 6375.649339286338, 6378.649174295412, 6426.582272152295, 3886.1839013806853, 4045.838166473367, 4061.837526498966, 4066.369712694537, 4074.266632006208, 4135.400366946776, 4150.7793330568, 4153.0, 4160.0, 4169.332906734908, 4182.769947652909, 4915.827946021872, 4923.433805112458, 4940.728259945666, 4963.851084467472, 5151.047056294523, 5747.798827041117, 5965.612235204698, 6096.420840020191, 6119.418655227746, 1193.8746431624727, 1250.8123781432857, 1296.8703129687144, 1364.34511434512, 1403.1440821099122, 746.4811955690743, 814.0556953933409, 872.2511364713708, 942.599395257013, 946.5172761891484, 4778.709748367991, 5110.0801855665595, 5158.509941555546, 5625.578081643893, 5676.205331253628, 5238.292830467914, 5864.296284445893, 5898.852528686817, 5941.642971720964, 6200.658963757037, 5418.864528386822, 5539.723013849291, 5582.888342233214, 5612.887742245132, 5689.061304884648, 2591.688997320334, 2595.9740402596112, 2637.4197676511135, 2730.945381092367, 2757.3244555084134, 4781.9043619128115, 4802.879928001758, 4953.176689287144, 4961.5286547777905, 5408.45915408456, 4900.580239885761, 5016.598672106295, 5040.521150490697, 5381.838544843661, 5402.028259685187, 4381.16757816014, 5052.595792336678, 5421.322334708161, 5421.9186712200135, 5433.212184233343, 4569.702969306984, 4821.9035619288115, 5179.368498922827, 5228.869278268074, 5292.047431462373, 3874.767513949172, 4533.342665313577, 5110.48895110486, 5138.3063286457345, 5191.922121168261, 4875.536824001714, 5085.542301192911, 5153.510416510426, 5410.702411367255, 5424.593155513431, 3571.0, 3574.8570057198463, 3583.4624806279267, 3584.7311451640708, 3611.1874828164505, 4412.367424053121, 4549.909001820011, 4909.9018019640125, 4941.912779188717, 5514.779408823602, 5859.94140058594, 5989.866991775661, 5990.7304171311525, 6005.609635373687, 6008.759649613967, 5082.33929589151, 6032.698365081641, 6037.516998640011, 6038.282772752191, 6069.453749162597, 5118.456124328095, 5750.683712395691, 5857.0, 5909.468147866713, 5915.633746501434, 5394.352677678704, 6052.303985041776, 6060.333363329942, 6076.665783381956, 6218.657973811484, 5659.660420374791, 5690.914636280377, 5819.476247137778, 5933.584649074523, 5950.4000079951], "value": 4154.539368289307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.9147606549182, 692.1071817355612, 710.8827043537816, 753.250515736842, 815.6125840225893, 11967.521299148035, 14859.33133009016, 14962.32669529871, 15017.624559386008, 15162.241887905588, 14444.06113602615, 14511.346989385476, 14612.342444589993, 14636.341364638616, 14646.267686615653, 663.9734410623594, 847.1740053447885, 873.2882700599023, 874.9518776467291, 878.0166213840507, 846.3948276981956, 868.1275318305126, 869.678219058949, 869.8042940338437, 881.1937077574012, 919.56320747645, 921.0973246218709, 921.5852866210232, 921.9677311294106, 922.9307801914883, 915.0803442540238, 915.244922938575, 915.7161280003154, 916.3768637326649, 916.5417291354323, 656.0389030070969, 673.8888083466222, 680.8876535371658, 681.512718406337, 683.6889215406978, 14853.331600077914, 14991.775123373158, 15007.849921500754, 15024.09855408679, 15078.849211507853, 14588.562343129723, 14652.41390344385, 14671.77992330116, 14845.851541484662, 14876.70246595062, 11823.586174483851, 11987.820182697267, 12186.634400967985, 12200.633980980585, 12447.564335248222, 3780.867669631577, 3798.1074447504816, 3971.860984865516, 4020.075382662004, 4024.4566983457153, 118908.0, 120640.79359206471, 120930.99999999913, 122177.0, 122443.38778306052, 9889.714337136127, 11270.887291127148, 11294.830577541343, 11331.32012079278, 11547.133964952494, 22834.885825570767, 22851.88574057119, 22860.542789144125, 22900.4274893129, 22917.968691408925, 6944.895826562605, 7780.844383112306, 7870.016247969004, 8027.237412445808, 8394.0, 4374.737515749065, 4386.1008493258805, 4428.335749637516, 4452.243118669834, 4461.57615026572, 3014.6834582368974, 3555.2356243407276, 3555.4489054196642, 3566.375884220251, 3575.7318201135017, 658.7746790968794, 660.9673078445345, 661.8709351676376, 665.890128128863, 670.785877561615, 591.1280860730388, 623.2271982741458, 626.6991843914947, 634.4480302137171, 641.9582727122722, 8855.433926173455, 9065.866766654168, 10135.341202821794, 10332.328398654214, 10400.0, 598.2491972574392, 632.7724215022841, 642.3768944124192, 660.6201434175368, 663.9668016599151, 4068.2800819839936, 4072.144849581621, 4126.66986641074, 4386.18855511725, 4391.67062470316, 126207.0, 144199.0, 156924.0, 160698.0, 161384.19307903387, 98440.0, 107996.46001770099, 110320.0, 110706.44646776875, 124873.37563312307, 94388.52805736064, 99033.0, 105029.0, 105946.94053059525, 110557.0, 8392.83214335722, 8475.957620211859, 9625.229981601595, 9846.595782880295, 10212.693619191436, 44248.0, 54217.18674219969, 59312.70343648427, 59484.26704528557, 61654.075188871306, 88890.0, 89075.0, 89332.0, 91179.54410227906, 91828.0, 13011.0, 13104.082714209913, 13133.802992955305, 13390.732185356434, 13738.0, 14713.33789979475, 14719.779203312173, 14770.704585908437, 14822.85177148258, 14886.478973235884, 13475.663108422368, 13634.590962271148, 13683.726325473634, 13958.860411395755, 14363.994520383472, 13439.260840653858, 13667.79498307546, 13819.516316928859, 14055.859441405864, 14331.283435828376, 12869.872729815348, 13469.39387727535, 13572.79640805369, 13585.313389042567, 14018.177636907138, 11199.384033878216, 11216.943915280372, 11471.655850324503, 11533.596324128615, 11645.88354116448, 9431.056894310514, 10614.840777388192, 10711.94644026775, 11553.768924621629, 11868.881311187122], "value": 7802.488922917793, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 130.0, 166.0, 155.0, 117.0, 101.0, 118.0, 116.0, 117.0, 118.0], "value": 125.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 136.0, 159.0, 108.0, 132.0, 127.0, 110.0, 158.0, 113.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 247.0, 274.0, 235.0, 197.0, 196.0, 202.0, 199.0, 188.0, 175.0], "value": 209.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 108.0, 110.0, 148.0, 59.0, 58.0, 58.0, 64.0, 136.0, 59.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 128.0, 77.0, 77.0, 69.0, 105.0, 56.0, 93.0, 143.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 74.0, 78.0, 115.0, 132.0, 122.0, 93.0, 88.0, 91.0, 78.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 97.0, 149.0, 91.0, 151.0, 103.0, 148.0, 135.0, 96.0], "value": 121.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 148.0, 142.0, 92.0, 93.0, 92.0, 93.0, 90.0, 93.0, 103.0], "value": 102.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 58.0, 58.0, 59.0, 58.0, 57.0, 58.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 72.0, 72.0, 79.0, 78.0, 80.0, 73.0, 71.0, 72.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 106.0, 106.0, 81.0, 89.0, 86.0, 104.0, 104.0, 107.0], "value": 96.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 152.0, 149.0, 151.0, 151.0, 152.0, 179.0, 195.0, 151.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 174.0, 187.0, 230.0, 170.0, 182.0, 169.0, 170.0, 172.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 85.0, 76.0, 68.0, 69.0, 68.0, 66.0, 67.0, 69.0], "value": 70.3, "unit": "score"}]}]} 12:17:53 INFO - Return code: 0 12:17:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:17:53 ERROR - # TBPL SUCCESS # 12:17:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:17:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:17:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:17:53 INFO - 2016-08-27 12:17:53.739 screenresolution[1673:10899] starting screenresolution argv=screenresolution get 12:17:53 INFO - 2016-08-27 12:17:53.742 screenresolution[1673:10899] Display 0: 1600x1200x32@60 12:17:53 INFO - 2016-08-27 12:17:53.748 screenresolution[1674:10902] starting screenresolution argv=screenresolution list 12:17:53 INFO - Available Modes on Display 0 12:17:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:17:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:17:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:17:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:17:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:17:53 INFO - Intel Iris: 12:17:53 INFO - Chipset Model: Intel Iris 12:17:53 INFO - Type: GPU 12:17:53 INFO - Bus: Built-In 12:17:53 INFO - VRAM (Dynamic, Max): 1536 MB 12:17:53 INFO - Vendor: Intel (0x8086) 12:17:53 INFO - Device ID: 0x0a2e 12:17:53 INFO - Revision ID: 0x0009 12:17:53 INFO - Displays: 12:17:53 INFO - Display: 12:17:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:17:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:17:53 INFO - Display Serial Number: 1600x1200 60 12:17:53 INFO - Main Display: Yes 12:17:53 INFO - Mirror: Off 12:17:53 INFO - Online: Yes 12:17:53 INFO - Rotation: Supported 12:17:53 INFO - Return code: 0 12:17:53 INFO - Running post-action listener: _resource_record_post_action 12:17:53 INFO - [mozharness: 2016-08-27 19:17:53.985968Z] Finished run-tests step (success) 12:17:53 INFO - Running post-run listener: _resource_record_post_run 12:17:54 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32930816; Write bytes: 708289024; Read time: 307; Write time: 2012 12:17:54 INFO - TinderboxPrint: CPU usage
54.8% 12:17:54 INFO - TinderboxPrint: I/O read bytes / time
32,930,816 / 307 12:17:54 INFO - TinderboxPrint: I/O write bytes / time
708,289,024 / 2,012 12:17:54 INFO - TinderboxPrint: CPU idle
2,186.2 (45.2%) 12:17:54 INFO - TinderboxPrint: CPU system
982.2 (20.3%) 12:17:54 INFO - TinderboxPrint: CPU user
1,673.4 (34.6%) 12:17:54 INFO - TinderboxPrint: Swap in / out
434,819,072 / 0 12:17:54 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392432128; Write bytes: 388024320; Read time: 29124; Write time: 736 12:17:54 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 31984640; Write bytes: 298174976; Read time: 293; Write time: 1228 12:17:54 INFO - Running post-run listener: _upload_blobber_files 12:17:54 INFO - Blob upload gear active. 12:17:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:17:54 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 12:17:54 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'] 12:17:54 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 12:17:54 INFO - Traceback (most recent call last): 12:17:54 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 12:17:54 INFO - main() 12:17:54 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 12:17:54 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 12:17:54 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 12:17:54 INFO - return set(response.json().get('whitelist', [])) 12:17:54 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 12:17:54 INFO - return json.loads(self.text or self.content, **kwargs) 12:17:54 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 12:17:54 INFO - return _default_decoder.decode(s) 12:17:54 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 12:17:54 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 12:17:54 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 12:17:54 INFO - raise ValueError("No JSON object could be decoded") 12:17:54 INFO - ValueError: No JSON object could be decoded 12:17:54 ERROR - Return code: 1 12:17:54 INFO - Setting buildbot property blobber_files to {} 12:17:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:17:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:17:54 INFO - Contents: 12:17:54 INFO - blobber_files:{} 12:17:54 INFO - Running post-run listener: copy_logs_to_upload_dir 12:17:54 INFO - Copying logs to upload dir... 12:17:54 INFO - mkdir: /builds/slave/test/build/upload/logs 12:17:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.418059 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-27 12:17:54.992463) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 12:17:54.996462) ========= 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.skeAxptiIX/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.geA5rIImJh/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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:{} build_url:https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010950 build_url: 'https://queue.taskcluster.net/v1/task/Bl4cTbIjQl29WQv1jY1QUw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 12:17:55.029099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 12:17:55.029430) ========= 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.skeAxptiIX/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.geA5rIImJh/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005272 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 12:17:55.078071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 12:17:55.078415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 12:17:55.078791) ========= ========= Total master_lag: 0.18 =========