builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0135 starttime: 1472243681.91 results: success (0) buildid: 20160826102618 builduid: fae1501d99ac4d6791cdd6643b550d53 revision: 9797d309cc749cacf1f8d092ca5186b0f0e2bdaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:41.909781) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:41.910260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:41.910539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:41.934214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:41.934599) ========= 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.z8m4pX9903/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.e70tv1JM9H/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-26 13:34:41-- 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% 173M=0s 2016-08-26 13:34:42 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:42.070471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:42.070785) ========= 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.z8m4pX9903/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.e70tv1JM9H/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.020512 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:42.119761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 13:34:42.120195) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9797d309cc749cacf1f8d092ca5186b0f0e2bdaf --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 9797d309cc749cacf1f8d092ca5186b0f0e2bdaf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z8m4pX9903/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.e70tv1JM9H/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-26 13:34:42,202 truncating revision to first 12 chars 2016-08-26 13:34:42,202 Setting DEBUG logging. 2016-08-26 13:34:42,202 attempt 1/10 2016-08-26 13:34:42,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9797d309cc74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 13:34:43,242 unpacking tar archive at: fx-team-9797d309cc74/testing/mozharness/ program finished with exit code 0 elapsedTime=1.299387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 13:34:43.442138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:43.442461) ========= script_repo_revision: 9797d309cc749cacf1f8d092ca5186b0f0e2bdaf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:43.442855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:43.443136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 13:34:43.461689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-26 13:34:43.462101) ========= /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.z8m4pX9903/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.e70tv1JM9H/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 13:34:43 INFO - MultiFileLogger online at 20160826 13:34:43 in /builds/slave/test 13:34:43 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 13:34:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:34:43 INFO - {'append_to_log': False, 13:34:43 INFO - 'base_work_dir': '/builds/slave/test', 13:34:43 INFO - 'blob_upload_branch': 'Fx-Team', 13:34:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:34:43 INFO - 'branch': 'Fx-Team', 13:34:43 INFO - 'buildbot_json_path': 'buildprops.json', 13:34:43 INFO - 'config_files': ('talos/mac_config.py',), 13:34:43 INFO - 'default_actions': ('clobber', 13:34:43 INFO - 'read-buildbot-config', 13:34:43 INFO - 'download-and-extract', 13:34:43 INFO - 'populate-webroot', 13:34:43 INFO - 'create-virtualenv', 13:34:43 INFO - 'install', 13:34:43 INFO - 'run-tests'), 13:34:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:34:43 INFO - 'download_minidump_stackwalk': True, 13:34:43 INFO - 'download_symbols': 'ondemand', 13:34:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:34:43 INFO - 'tooltool.py': '/tools/tooltool.py', 13:34:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:34:43 INFO - '/tools/misc-python/virtualenv.py')}, 13:34:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:34:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:34:43 INFO - 'installer_path': 'installer.exe', 13:34:43 INFO - 'log_level': 'info', 13:34:43 INFO - 'log_name': 'talos', 13:34:43 INFO - 'log_to_console': True, 13:34:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:34:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:34:43 INFO - 'opt_config_files': (), 13:34:43 INFO - 'pip_index': False, 13:34:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:34:43 INFO - 'cmd': ('bash', 13:34:43 INFO - '-c', 13:34:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:34:43 INFO - 'enabled': True, 13:34:43 INFO - 'halt_on_failure': False, 13:34:43 INFO - 'name': 'check_screen_resolution'},), 13:34:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:34:43 INFO - 'cmd': ('bash', 13:34:43 INFO - '-c', 13:34:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:34:43 INFO - 'enabled': True, 13:34:43 INFO - 'halt_on_failure': False, 13:34:43 INFO - 'name': 'check_screen_resolution'},), 13:34:43 INFO - 'run_cmd_checks_enabled': True, 13:34:43 INFO - 'sps_profile': False, 13:34:43 INFO - 'sps_profile_interval': 0, 13:34:43 INFO - 'suite': 'dromaeojs-e10s', 13:34:43 INFO - 'system_bits': '32', 13:34:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:34:43 INFO - 'title': 't-yosemite-r7-0135', 13:34:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:34:43 INFO - 'use_talos_json': True, 13:34:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:34:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:34:43 INFO - 'work_dir': 'build'} 13:34:43 INFO - [mozharness: 2016-08-26 20:34:43.664914Z] Running clobber step. 13:34:43 INFO - Running pre-action listener: _resource_record_pre_action 13:34:43 INFO - Running main action method: clobber 13:34:43 INFO - rmtree: /builds/slave/test/build 13:34:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:34:44 INFO - Running post-action listener: _resource_record_post_action 13:34:44 INFO - [mozharness: 2016-08-26 20:34:44.624048Z] Finished clobber step (success) 13:34:44 INFO - [mozharness: 2016-08-26 20:34:44.624177Z] Running read-buildbot-config step. 13:34:44 INFO - Running pre-action listener: _resource_record_pre_action 13:34:44 INFO - Running main action method: read_buildbot_config 13:34:44 INFO - Using buildbot properties: 13:34:44 INFO - { 13:34:44 INFO - "project": "", 13:34:44 INFO - "product": "firefox", 13:34:44 INFO - "script_repo_revision": "production", 13:34:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:34:44 INFO - "repository": "", 13:34:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:34:44 INFO - "buildid": "20160826102618", 13:34:44 INFO - "pgo_build": "False", 13:34:44 INFO - "basedir": "/builds/slave/test", 13:34:44 INFO - "buildnumber": 34, 13:34:44 INFO - "slavename": "t-yosemite-r7-0135", 13:34:44 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:34:44 INFO - "platform": "yosemite_r7", 13:34:44 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 13:34:44 INFO - "branch": "fx-team", 13:34:44 INFO - "repo_path": "integration/fx-team", 13:34:44 INFO - "revision": "9797d309cc749cacf1f8d092ca5186b0f0e2bdaf", 13:34:44 INFO - "stage_platform": "macosx64", 13:34:44 INFO - "builduid": "fae1501d99ac4d6791cdd6643b550d53", 13:34:44 INFO - "slavebuilddir": "test" 13:34:44 INFO - } 13:34:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:34:44 INFO - Running post-action listener: _resource_record_post_action 13:34:44 INFO - [mozharness: 2016-08-26 20:34:44.627335Z] Finished read-buildbot-config step (success) 13:34:44 INFO - [mozharness: 2016-08-26 20:34:44.627445Z] Running download-and-extract step. 13:34:44 INFO - Running pre-action listener: _resource_record_pre_action 13:34:44 INFO - Running main action method: download_and_extract 13:34:44 INFO - mkdir: /builds/slave/test/build/tests 13:34:44 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')]} 13:34:44 INFO - trying https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:34:45 INFO - Downloaded 1199 bytes. 13:34:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:34:45 INFO - Using the following test package requirements: 13:34:45 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:34:45 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:34:45 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:34:45 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'jsshell-mac.zip'], 13:34:45 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:34:45 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:34:45 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:34:45 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:34:45 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:34:45 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:34:45 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:34:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:34:45 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')]} 13:34:45 INFO - trying https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:34:46 INFO - Downloaded 16368050 bytes. 13:34:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:34:53 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 13:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:53 INFO - trying https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:34:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:34:54 INFO - Downloaded 16368050 bytes. 13:34:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:01 INFO - trying https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:35:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:35:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:35:02 INFO - Downloaded 14413998 bytes. 13:35:02 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:02 INFO - trying https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:35:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/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 13:35:05 INFO - Downloaded 111601883 bytes. 13:35:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:35:05 INFO - mkdir: /builds/slave/test/properties 13:35:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:35:05 INFO - Writing to file /builds/slave/test/properties/build_url 13:35:05 INFO - Contents: 13:35:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:35:06 INFO - Running post-action listener: _resource_record_post_action 13:35:06 INFO - Running post-action listener: set_extra_try_arguments 13:35:06 INFO - [mozharness: 2016-08-26 20:35:06.448691Z] Finished download-and-extract step (success) 13:35:06 INFO - [mozharness: 2016-08-26 20:35:06.448845Z] Running populate-webroot step. 13:35:06 INFO - Running pre-action listener: _resource_record_pre_action 13:35:06 INFO - Running main action method: populate_webroot 13:35:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:35:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:35:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:35:06 INFO - '--tppagecycles', 13:35:06 INFO - '7'], 13:35:06 INFO - 'tests': ['tsvgm']}}, 13:35:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:35:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:35:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:35:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:35:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['damp', 'tps']}, 13:35:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'tests': ['damp', 'tps']}, 13:35:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['dromaeo_dom']}, 13:35:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:35:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['basic_compositor_video']}, 13:35:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:35:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['a11yr', 13:35:06 INFO - 'ts_paint', 13:35:06 INFO - 'tpaint', 13:35:06 INFO - 'sessionrestore', 13:35:06 INFO - 'sessionrestore_no_auto_restore', 13:35:06 INFO - 'tabpaint']}, 13:35:06 INFO - 'other-e10s': {'tests': ['a11yr', 13:35:06 INFO - 'ts_paint', 13:35:06 INFO - 'tpaint', 13:35:06 INFO - 'sessionrestore', 13:35:06 INFO - 'sessionrestore_no_auto_restore', 13:35:06 INFO - 'tabpaint']}, 13:35:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:35:06 INFO - 'ts_paint', 13:35:06 INFO - 'tpaint', 13:35:06 INFO - 'sessionrestore', 13:35:06 INFO - 'sessionrestore_no_auto_restore', 13:35:06 INFO - 'tabpaint']}, 13:35:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:35:06 INFO - 'ts_paint', 13:35:06 INFO - 'tpaint', 13:35:06 INFO - 'sessionrestore', 13:35:06 INFO - 'sessionrestore_no_auto_restore', 13:35:06 INFO - 'tabpaint']}, 13:35:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['a11yr', 13:35:06 INFO - 'ts_paint', 13:35:06 INFO - 'tpaint', 13:35:06 INFO - 'sessionrestore', 13:35:06 INFO - 'sessionrestore_no_auto_restore', 13:35:06 INFO - 'tabpaint']}, 13:35:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['a11yr', 13:35:06 INFO - 'ts_paint', 13:35:06 INFO - 'tpaint', 13:35:06 INFO - 'sessionrestore', 13:35:06 INFO - 'sessionrestore_no_auto_restore', 13:35:06 INFO - 'tabpaint']}, 13:35:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['tsvgx', 13:35:06 INFO - 'tsvgr_opacity', 13:35:06 INFO - 'tart', 13:35:06 INFO - 'tscrollx', 13:35:06 INFO - 'cart']}, 13:35:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:35:06 INFO - 'tsvgr_opacity', 13:35:06 INFO - 'tart', 13:35:06 INFO - 'tscrollx', 13:35:06 INFO - 'cart']}, 13:35:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'talos_options': ['--disable-e10s'], 13:35:06 INFO - 'tests': ['tp5o']}, 13:35:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'tests': ['tp5o']}, 13:35:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'talos_options': ['--disable-e10s', 13:35:06 INFO - '--xperf_path', 13:35:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:06 INFO - 'tests': ['tp5n']}, 13:35:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:06 INFO - 'talos_options': ['--xperf_path', 13:35:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:06 INFO - 'tests': ['tp5n']}}, 13:35:06 INFO - 'talos.zip': {'path': '', 13:35:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:35:06 INFO - Running post-action listener: _resource_record_post_action 13:35:06 INFO - [mozharness: 2016-08-26 20:35:06.467806Z] Finished populate-webroot step (success) 13:35:06 INFO - [mozharness: 2016-08-26 20:35:06.467920Z] Running create-virtualenv step. 13:35:06 INFO - Running pre-action listener: _resource_record_pre_action 13:35:06 INFO - Running main action method: create_virtualenv 13:35:06 INFO - Creating virtualenv /builds/slave/test/build/venv 13:35:06 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 13:35:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:35:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:35:06 INFO - Using real prefix '/tools/python27' 13:35:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:35:07 INFO - Installing distribute.............................................................................................................................................................................................done. 13:35:10 INFO - Installing pip.................done. 13:35:10 INFO - Return code: 0 13:35:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:35:10 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')]} 13:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:10 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')]} 13:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:10 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:10 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 13:35:10 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 13:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:10 INFO - 'HOME': '/Users/cltbld', 13:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:10 INFO - 'LOGNAME': 'cltbld', 13:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:10 INFO - 'MOZ_NO_REMOTE': '1', 13:35:10 INFO - 'NO_EM_RESTART': '1', 13:35:10 INFO - 'PAGER': '/bin/cat', 13:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:10 INFO - 'PWD': '/builds/slave/test', 13:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:10 INFO - 'SHELL': '/bin/bash', 13:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:10 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:10 INFO - 'USER': 'cltbld', 13:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:10 INFO - 'XPC_FLAGS': '0x0', 13:35:10 INFO - 'XPC_SERVICE_NAME': '0', 13:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:10 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 13:35:10 INFO - Cleaning up... 13:35:10 INFO - Return code: 0 13:35:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:35:10 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')]} 13:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:10 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')]} 13:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:10 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:10 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 13:35:10 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 13:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:10 INFO - 'HOME': '/Users/cltbld', 13:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:10 INFO - 'LOGNAME': 'cltbld', 13:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:10 INFO - 'MOZ_NO_REMOTE': '1', 13:35:10 INFO - 'NO_EM_RESTART': '1', 13:35:10 INFO - 'PAGER': '/bin/cat', 13:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:10 INFO - 'PWD': '/builds/slave/test', 13:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:10 INFO - 'SHELL': '/bin/bash', 13:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:10 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:10 INFO - 'USER': 'cltbld', 13:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:10 INFO - 'XPC_FLAGS': '0x0', 13:35:10 INFO - 'XPC_SERVICE_NAME': '0', 13:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:10 INFO - Downloading/unpacking psutil>=3.1.1 13:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:35:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:13 INFO - Installing collected packages: psutil 13:35:13 INFO - Running setup.py install for psutil 13:35:13 INFO - building 'psutil._psutil_osx' extension 13:35:13 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 13:35:14 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 13:35:14 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 13:35:14 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 13:35:14 INFO - building 'psutil._psutil_posix' extension 13:35:14 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 13:35:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:35:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:35:14 INFO - ^ 13:35:14 INFO - 1 warning generated. 13:35:14 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 13:35:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:14 INFO - Successfully installed psutil 13:35:14 INFO - Cleaning up... 13:35:14 INFO - Return code: 0 13:35:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:35:14 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')]} 13:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:14 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')]} 13:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:14 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:14 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 13:35:14 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 13:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:14 INFO - 'HOME': '/Users/cltbld', 13:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:14 INFO - 'LOGNAME': 'cltbld', 13:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:14 INFO - 'MOZ_NO_REMOTE': '1', 13:35:14 INFO - 'NO_EM_RESTART': '1', 13:35:14 INFO - 'PAGER': '/bin/cat', 13:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:14 INFO - 'PWD': '/builds/slave/test', 13:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:14 INFO - 'SHELL': '/bin/bash', 13:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:14 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:14 INFO - 'USER': 'cltbld', 13:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:14 INFO - 'XPC_FLAGS': '0x0', 13:35:14 INFO - 'XPC_SERVICE_NAME': '0', 13:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:35:14 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 13:35:14 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 13:35:14 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 13:35:14 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 13:35:14 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 13:35:14 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 13:35:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:35:17 INFO - Installing collected packages: mozsystemmonitor 13:35:17 INFO - Running setup.py install for mozsystemmonitor 13:35:17 INFO - Successfully installed mozsystemmonitor 13:35:17 INFO - Cleaning up... 13:35:17 INFO - Return code: 0 13:35:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:17 INFO - 'HOME': '/Users/cltbld', 13:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:17 INFO - 'LOGNAME': 'cltbld', 13:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:17 INFO - 'MOZ_NO_REMOTE': '1', 13:35:17 INFO - 'NO_EM_RESTART': '1', 13:35:17 INFO - 'PAGER': '/bin/cat', 13:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:17 INFO - 'PWD': '/builds/slave/test', 13:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:17 INFO - 'SHELL': '/bin/bash', 13:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:17 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:17 INFO - 'USER': 'cltbld', 13:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:17 INFO - 'XPC_FLAGS': '0x0', 13:35:17 INFO - 'XPC_SERVICE_NAME': '0', 13:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:17 INFO - Downloading/unpacking jsonschema==2.5.1 13:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:35:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:20 INFO - Downloading functools32-3.2.3-2.tar.gz 13:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:35:20 INFO - warning: no files found matching '*.txt' 13:35:20 INFO - no previously-included directories found matching 'build' 13:35:20 INFO - no previously-included directories found matching 'dist' 13:35:20 INFO - no previously-included directories found matching '.git*' 13:35:20 INFO - Installing collected packages: jsonschema, functools32 13:35:20 INFO - Running setup.py install for functools32 13:35:21 INFO - warning: no files found matching '*.txt' 13:35:21 INFO - no previously-included directories found matching 'build' 13:35:21 INFO - no previously-included directories found matching 'dist' 13:35:21 INFO - no previously-included directories found matching '.git*' 13:35:21 INFO - Successfully installed jsonschema functools32 13:35:21 INFO - Cleaning up... 13:35:21 INFO - Return code: 0 13:35:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:35:21 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')]} 13:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:21 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')]} 13:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:21 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:21 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 13:35:21 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 13:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:21 INFO - 'HOME': '/Users/cltbld', 13:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:21 INFO - 'LOGNAME': 'cltbld', 13:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:21 INFO - 'MOZ_NO_REMOTE': '1', 13:35:21 INFO - 'NO_EM_RESTART': '1', 13:35:21 INFO - 'PAGER': '/bin/cat', 13:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:21 INFO - 'PWD': '/builds/slave/test', 13:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:21 INFO - 'SHELL': '/bin/bash', 13:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:21 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:21 INFO - 'USER': 'cltbld', 13:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:21 INFO - 'XPC_FLAGS': '0x0', 13:35:21 INFO - 'XPC_SERVICE_NAME': '0', 13:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:35:21 INFO - Cleaning up... 13:35:21 INFO - Return code: 0 13:35:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:35:21 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')]} 13:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:21 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')]} 13:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:21 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:21 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 13:35:21 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 13:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:21 INFO - 'HOME': '/Users/cltbld', 13:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:21 INFO - 'LOGNAME': 'cltbld', 13:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:21 INFO - 'MOZ_NO_REMOTE': '1', 13:35:21 INFO - 'NO_EM_RESTART': '1', 13:35:21 INFO - 'PAGER': '/bin/cat', 13:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:21 INFO - 'PWD': '/builds/slave/test', 13:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:21 INFO - 'SHELL': '/bin/bash', 13:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:21 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:21 INFO - 'USER': 'cltbld', 13:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:21 INFO - 'XPC_FLAGS': '0x0', 13:35:21 INFO - 'XPC_SERVICE_NAME': '0', 13:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:21 INFO - Downloading/unpacking blobuploader==1.2.4 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:24 INFO - Downloading blobuploader-1.2.4.tar.gz 13:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:35:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:35:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:25 INFO - Downloading docopt-0.6.1.tar.gz 13:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:35:25 INFO - Installing collected packages: blobuploader, requests, docopt 13:35:25 INFO - Running setup.py install for blobuploader 13:35:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:35:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:35:25 INFO - Running setup.py install for requests 13:35:26 INFO - Running setup.py install for docopt 13:35:26 INFO - Successfully installed blobuploader requests docopt 13:35:26 INFO - Cleaning up... 13:35:26 INFO - Return code: 0 13:35:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:26 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:26 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 13:35:26 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 13:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:26 INFO - 'HOME': '/Users/cltbld', 13:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:26 INFO - 'LOGNAME': 'cltbld', 13:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:26 INFO - 'MOZ_NO_REMOTE': '1', 13:35:26 INFO - 'NO_EM_RESTART': '1', 13:35:26 INFO - 'PAGER': '/bin/cat', 13:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:26 INFO - 'PWD': '/builds/slave/test', 13:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:26 INFO - 'SHELL': '/bin/bash', 13:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:26 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:26 INFO - 'USER': 'cltbld', 13:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:26 INFO - 'XPC_FLAGS': '0x0', 13:35:26 INFO - 'XPC_SERVICE_NAME': '0', 13:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hiHyzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-YrS6Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-lMqEri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-5KLymE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-jN1OtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-a3Vwa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FlPkdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-2KTrKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-iSyWd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-xbRzTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-EsDGGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CiIMKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-bO5I6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FGBpcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:28 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ikCSwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:28 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-HHPzGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:28 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-niNUP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:35:28 INFO - Running setup.py install for manifestparser 13:35:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:35:28 INFO - Running setup.py install for mozcrash 13:35:28 INFO - Running setup.py install for mozdebug 13:35:28 INFO - Running setup.py install for mozdevice 13:35:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:35:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:35:28 INFO - Running setup.py install for mozfile 13:35:29 INFO - Running setup.py install for mozhttpd 13:35:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:35:29 INFO - Running setup.py install for mozinfo 13:35:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:35:29 INFO - Running setup.py install for mozInstall 13:35:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:35:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:35:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:35:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:35:29 INFO - Running setup.py install for mozleak 13:35:29 INFO - Running setup.py install for mozlog 13:35:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:35:29 INFO - Running setup.py install for moznetwork 13:35:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:35:30 INFO - Running setup.py install for mozprocess 13:35:30 INFO - Running setup.py install for mozprofile 13:35:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:35:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:35:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:35:30 INFO - Running setup.py install for mozrunner 13:35:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:35:30 INFO - Running setup.py install for mozscreenshot 13:35:30 INFO - Running setup.py install for moztest 13:35:30 INFO - Running setup.py install for mozversion 13:35:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:35:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:35:30 INFO - Cleaning up... 13:35:30 INFO - Return code: 0 13:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:30 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')]} 13:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:30 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')]} 13:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:30 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:30 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 13:35:30 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 13:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:30 INFO - 'HOME': '/Users/cltbld', 13:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:30 INFO - 'LOGNAME': 'cltbld', 13:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:30 INFO - 'MOZ_NO_REMOTE': '1', 13:35:30 INFO - 'NO_EM_RESTART': '1', 13:35:30 INFO - 'PAGER': '/bin/cat', 13:35:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:30 INFO - 'PWD': '/builds/slave/test', 13:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:30 INFO - 'SHELL': '/bin/bash', 13:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:30 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:30 INFO - 'USER': 'cltbld', 13:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:30 INFO - 'XPC_FLAGS': '0x0', 13:35:30 INFO - 'XPC_SERVICE_NAME': '0', 13:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:31 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-9WTtPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:31 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)) 13:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:31 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CJGLP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:31 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)) 13:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:31 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-rw8ZiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:31 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)) 13:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:31 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-SsI4GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:31 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)) 13:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:31 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ouNT6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:31 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)) 13:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:31 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-rd8q36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:31 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)) 13:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:31 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-zfG4cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-SLQGJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8HzOi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-iP3jCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ibAgHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-pEH7OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ZJpyNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-1XR4zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8jUvmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-vyFtXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:32 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)) 13:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:32 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-YVzUA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:33 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)) 13:35:33 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)) 13:35:33 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)) 13:35:33 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)) 13:35:33 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)) 13:35:33 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)) 13:35:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:35:33 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 13:35:33 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 13:35:33 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 13:35:33 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 13:35:33 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 13:35:33 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 13:35:35 INFO - Downloading blessings-1.6.tar.gz 13:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:35:35 INFO - Installing collected packages: blessings 13:35:35 INFO - Running setup.py install for blessings 13:35:35 INFO - Successfully installed blessings 13:35:35 INFO - Cleaning up... 13:35:35 INFO - Return code: 0 13:35:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:36 INFO - Reading from file tmpfile_stdout 13:35:36 INFO - Current package versions: 13:35:36 INFO - blessings == 1.6 13:35:36 INFO - blobuploader == 1.2.4 13:35:36 INFO - docopt == 0.6.1 13:35:36 INFO - functools32 == 3.2.3-2 13:35:36 INFO - jsonschema == 2.5.1 13:35:36 INFO - manifestparser == 1.1 13:35:36 INFO - mozInstall == 1.12 13:35:36 INFO - mozcrash == 0.17 13:35:36 INFO - mozdebug == 0.1 13:35:36 INFO - mozdevice == 0.48 13:35:36 INFO - mozfile == 1.2 13:35:36 INFO - mozhttpd == 0.7 13:35:36 INFO - mozinfo == 0.9 13:35:36 INFO - mozleak == 0.1 13:35:36 INFO - mozlog == 3.3 13:35:36 INFO - moznetwork == 0.27 13:35:36 INFO - mozprocess == 0.23 13:35:36 INFO - mozprofile == 0.28 13:35:36 INFO - mozrunner == 6.12 13:35:36 INFO - mozscreenshot == 0.1 13:35:36 INFO - mozsystemmonitor == 0.3 13:35:36 INFO - moztest == 0.7 13:35:36 INFO - mozversion == 1.4 13:35:36 INFO - psutil == 3.1.1 13:35:36 INFO - requests == 1.2.3 13:35:36 INFO - wsgiref == 0.1.2 13:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:36 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:36 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 13:35:36 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 13:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:36 INFO - 'HOME': '/Users/cltbld', 13:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:36 INFO - 'LOGNAME': 'cltbld', 13:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:36 INFO - 'MOZ_NO_REMOTE': '1', 13:35:36 INFO - 'NO_EM_RESTART': '1', 13:35:36 INFO - 'PAGER': '/bin/cat', 13:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:36 INFO - 'PWD': '/builds/slave/test', 13:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:36 INFO - 'SHELL': '/bin/bash', 13:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:36 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:36 INFO - 'USER': 'cltbld', 13:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:36 INFO - 'XPC_FLAGS': '0x0', 13:35:36 INFO - 'XPC_SERVICE_NAME': '0', 13:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 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)) 13:35:36 INFO - Cleaning up... 13:35:36 INFO - Return code: 0 13:35:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:36 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 0x101ed6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd449d9e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, '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.z8m4pX9903/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.e70tv1JM9H/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 13:35:36 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 13:35:36 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 13:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:36 INFO - 'HOME': '/Users/cltbld', 13:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:36 INFO - 'LOGNAME': 'cltbld', 13:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:36 INFO - 'MOZ_NO_REMOTE': '1', 13:35:36 INFO - 'NO_EM_RESTART': '1', 13:35:36 INFO - 'PAGER': '/bin/cat', 13:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:36 INFO - 'PWD': '/builds/slave/test', 13:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:36 INFO - 'SHELL': '/bin/bash', 13:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:35:36 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:36 INFO - 'USER': 'cltbld', 13:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:36 INFO - 'XPC_FLAGS': '0x0', 13:35:36 INFO - 'XPC_SERVICE_NAME': '0', 13:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:35:36 INFO - Cleaning up... 13:35:36 INFO - Return code: 0 13:35:36 INFO - Running post-action listener: _resource_record_post_action 13:35:36 INFO - Running post-action listener: _start_resource_monitoring 13:35:36 INFO - Starting resource monitoring. 13:35:36 INFO - [mozharness: 2016-08-26 20:35:36.694613Z] Finished create-virtualenv step (success) 13:35:36 INFO - [mozharness: 2016-08-26 20:35:36.695429Z] Running install step. 13:35:36 INFO - Running pre-action listener: _resource_record_pre_action 13:35:36 INFO - Running main action method: install 13:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:36 INFO - Reading from file tmpfile_stdout 13:35:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:35:37 INFO - Reading from file tmpfile_stdout 13:35:37 INFO - Output received: 13:35:37 INFO - Usage: mozinstall [options] installer 13:35:37 INFO - Options: 13:35:37 INFO - -h, --help show this help message and exit 13:35:37 INFO - -d DEST, --destination=DEST 13:35:37 INFO - Directory to install application into. [default: 13:35:37 INFO - "/builds/slave/test"] 13:35:37 INFO - --app=APP Application being installed. [default: firefox] 13:35:37 INFO - mkdir: /builds/slave/test/build/application 13:35:37 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'] 13:35:37 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 13:36:10 INFO - Reading from file tmpfile_stdout 13:36:10 INFO - Output received: 13:36:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:36:10 INFO - Running post-action listener: _resource_record_post_action 13:36:10 INFO - [mozharness: 2016-08-26 20:36:10.826445Z] Finished install step (success) 13:36:10 INFO - [mozharness: 2016-08-26 20:36:10.826617Z] Running run-tests step. 13:36:10 INFO - Running pre-action listener: _resource_record_pre_action 13:36:10 INFO - Running main action method: run_tests 13:36:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:36:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:36:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:36:10 INFO - 2016-08-26 13:36:10.841 screenresolution[1966:14062] starting screenresolution argv=screenresolution get 13:36:10 INFO - 2016-08-26 13:36:10.844 screenresolution[1966:14062] Display 0: 1600x1200x32@60 13:36:10 INFO - 2016-08-26 13:36:10.850 screenresolution[1967:14065] starting screenresolution argv=screenresolution list 13:36:10 INFO - Available Modes on Display 0 13:36:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:36:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:36:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:36:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:36:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:36:11 INFO - Intel Iris: 13:36:11 INFO - Chipset Model: Intel Iris 13:36:11 INFO - Type: GPU 13:36:11 INFO - Bus: Built-In 13:36:11 INFO - VRAM (Dynamic, Max): 1536 MB 13:36:11 INFO - Vendor: Intel (0x8086) 13:36:11 INFO - Device ID: 0x0a2e 13:36:11 INFO - Revision ID: 0x0009 13:36:11 INFO - Displays: 13:36:11 INFO - Display: 13:36:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:36:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:36:11 INFO - Display Serial Number: 1600x1200 60 13:36:11 INFO - Main Display: Yes 13:36:11 INFO - Mirror: Off 13:36:11 INFO - Online: Yes 13:36:11 INFO - Rotation: Supported 13:36:11 INFO - Return code: 0 13:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:36:11 INFO - Python 2.7.3 13:36:11 INFO - Return code: 0 13:36:11 INFO - grabbing minidump binary from tooltool 13:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:36:11 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 0x101e3ad30>, '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 0x101b9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e32b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:36:11 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 13:36:11 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 13:36:11 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 13:36:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:36:11 INFO - Return code: 0 13:36:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:36:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:36:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:36:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:36:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:36:11 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/Jdrx4_dvRdCAba7URD1Dkw/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 13:36:11 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/Jdrx4_dvRdCAba7URD1Dkw/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 13:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z8m4pX9903/Render', 13:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:11 INFO - 'HOME': '/Users/cltbld', 13:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:11 INFO - 'LOGNAME': 'cltbld', 13:36:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:11 INFO - 'MOZ_NO_REMOTE': '1', 13:36:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:11 INFO - 'NO_EM_RESTART': '1', 13:36:11 INFO - 'PAGER': '/bin/cat', 13:36:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:11 INFO - 'PWD': '/builds/slave/test', 13:36:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:11 INFO - 'SHELL': '/bin/bash', 13:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e70tv1JM9H/Listeners', 13:36:11 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:11 INFO - 'USER': 'cltbld', 13:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:11 INFO - 'XPC_FLAGS': '0x0', 13:36:11 INFO - 'XPC_SERVICE_NAME': '0', 13:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:11 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/Jdrx4_dvRdCAba7URD1Dkw/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 13:36:11 INFO - mozversion application_buildid: 20160826102618 13:36:11 INFO - mozversion application_changeset: 9797d309cc749cacf1f8d092ca5186b0f0e2bdaf 13:36:11 INFO - mozversion application_display_name: Nightly 13:36:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:36:11 INFO - mozversion application_name: Firefox 13:36:11 INFO - mozversion application_remotingname: firefox 13:36:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:36:11 INFO - mozversion application_vendor: Mozilla 13:36:11 INFO - mozversion application_version: 51.0a1 13:36:11 INFO - mozversion platform_buildid: 20160826102618 13:36:11 INFO - mozversion platform_changeset: 9797d309cc749cacf1f8d092ca5186b0f0e2bdaf 13:36:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:36:11 INFO - mozversion platform_version: 51.0a1 13:36:11 INFO - using testdate: 1472243771 13:36:11 INFO - actual date: 1472243771 13:36:11 INFO - starting webserver on 'localhost:49526' 13:36:11 INFO - SUITE-START | Running 2 tests 13:36:11 INFO - TEST-START | dromaeo_css 13:36:11 INFO - operating with platform_type : mac_ 13:36:11 INFO - Initialising browser for dromaeo_css test... 13:36:11 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpD6nYql/profile http://localhost:49526/getInfo.html) 13:36:14 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 13:36:14 INFO - PROCESS | 1977 | colorDepth:24 13:36:14 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 13:36:14 INFO - PROCESS | 1977 | __metrics 13:36:14 ERROR - PROCESS | 1977 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:36:15 INFO - TEST-INFO | 1977: exit 0 13:36:15 INFO - Browser initialized. 13:36:15 INFO - Running cycle 1/1 for dromaeo_css test... 13:36:15 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpD6nYql/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:27 INFO - PROCESS | 1980 | RSS: Main: 243908608 13:36:27 INFO - PROCESS | 1980 | 13:37:16 INFO - PROCESS | 1980 | 1472243836703 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] 13:39:29 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49526/tests/dromaeo/cssquery-ext.html) 13:39:30 INFO - PROCESS | 1980 | RSS: Main: 262885376 13:39:30 INFO - PROCESS | 1980 | 13:42:33 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49526/tests/dromaeo/cssquery-ext.html (next: http://localhost:49526/tests/dromaeo/cssquery-jquery.html) 13:42:33 INFO - PROCESS | 1980 | RSS: Main: 268627968 13:42:33 INFO - PROCESS | 1980 | 13:45:35 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49526/tests/dromaeo/cssquery-mootools.html) 13:45:36 INFO - PROCESS | 1980 | RSS: Main: 274374656 13:45:36 INFO - PROCESS | 1980 | 13:48:38 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49526/tests/dromaeo/cssquery-prototype.html) 13:48:38 INFO - PROCESS | 1980 | RSS: Main: 269639680 13:48:38 INFO - PROCESS | 1980 | 13:51:41 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49526/tests/dromaeo/cssquery-yui.html) 13:51:42 INFO - PROCESS | 1980 | RSS: Main: 277057536 13:51:42 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49526/tests/dromaeo/cssquery-yui.html (next: http://localhost:49526/tests/dromaeo/cssquery-dojo.html) 13:54:45 INFO - PROCESS | 1980 | RSS: Main: 278843392 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | __start_tp_report 13:54:45 INFO - PROCESS | 1980 | _x_x_mozilla_page_load 13:54:45 INFO - PROCESS | 1980 | _x_x_mozilla_page_load_details 13:54:45 INFO - PROCESS | 1980 | |i|pagename|runs| 13:54:45 INFO - PROCESS | 1980 | |0;dojo.html;3424.79451232926;3427.28027114306;3455.118944669109;3458;3461.325041616884;4986.252062190673;5485.945140548593;5700.800471983482;5897.587168898179;5923.229980102591;5789.739461724222;5800.622959507629;5900.704964751767;5912.763489460427;5922.407759224076;5208;5277.604179686519;5289.814856480024;5364.275822763935;5378.784848606051;5346.171343441753;5356.7321633918145;5381.408045115034;5428.83713488594;5458.235846981426;5212.40057393397;5282.550983166436;5307.2569840222395;5324.787008519655;5355.544778693816;5266.8683282917855;5313.867153321159;5320.920186197211;5323.387810401815;5353.9732301338245;5204.739763011834;5239.764210610531;5251.343582052244;5265.210218467222;5317.867053323659;5641.71791410432;5706.77172913083;5786.276715410574;5826.329972053183;5838.299404071496;6208.751649933997;6213.471854892339;6268.15379923709;6273.184486016834;6277.968610156966;5219.321488206547;6225.087691326506;6255.781047663356;6271.78048768291;6274.623522588659;5765.164051212634;5850.590458667937;5886;5903.940960590425;5937.732802023919;6429.54993150475;6434.8391290218115;6440.25937017249;6456;6472.805815825533;5173.4826517347965;6209.9068513972325;6231.875362492725;6249.75000999964;6254.937450625526;4795.976020119947;6116.33577150815;6156.5998210116195;6174.969125154345;6278.183836101278;5213.296205012351;6248.968755156195;6267.780627678009;6271.937280627227;6277;5439.891202175934;6235.220597425322;6245.28179259391;6248.906441372833;6264.2796078451565;4917.508249175054;4953.925691114636;4984.90030199394;5000.049990501793;5057.72182529957;4478.440194975628;4486.955130448719;4488.551144885485;4508.954910450919;4546.204414227563;5767.8558036049435;5896.1450589664255;5906.793262235801;5936.5844390892225;5966.701664916824;5160.20016897374;6128.050152226412;6215.160953271341;6250.624962502174;6270.435660790459;5844.211031510777;5874.236349274653;5889.587728858939;5897.351291357947;5939.287285525765;5503.229547863302;5503.9174412383845;5520;5534.695591742412;5538.418466061086;5763.913541296968;6111.022236442326;6316.873662526816;6513.316101809337;6517.511186661114;6223.626582405071;6259.467945224706;6261.405166509175;6266.342034086355;6287.371262873676;6459.515536334888;6526.738930442919;6532.673366331569;6557.475401967736;6571.934280657323;6123.160610921377;6151.50787936955;6189;6208.906866397098;6264.373562643699;6234.719437625408;6236.501079913505;6254.593451425642;6256.968715156395;6257;6187.319394866651;6197.318294987457;6201.6899155041165;6207.81376558704;6211.254649442096;4907.828226012215;6097.359777223328;6113.419225173601;6139.154842350836;6158.137860699595;5925.40745925404;5931.1399847021075;6044.395560443921;6061.605995610271;6129.8467538310115;6142.969285153546;6186.783462578788;6198.2252218472695;6201.596896201732;6228.688565571794;5914.970425147847;5928.347881733092;5973.731182096903;6091.5126789857595;6101.267847858107 13:54:45 INFO - PROCESS | 1980 | |1;ext.html;499.5828483216515;504.0649595001275;520.8749900023994;528.7462018231251;536.8094326514088;35288.64711352889;38219.80890095549;40455.393169102485;41104.588954110484;41142.794286028606;41723.165536689325;42239.78880105603;42255.78872105643;42268.36597451041;42421.36367954483;9626.855597166048;9832.115109640132;9839.90160098397;9867.358621689604;9900.702978910644;9631.951840240788;9745.31782775206;9763.804723905518;9767;9772;9723.02769723029;9767.120959113678;9773.511324433786;9798.363106398061;9800.362976406546;9678.419294842262;9731.610735570604;9755.609775609038;9760.609575616967;9769.951150244238;9332.206762425201;9704.90295097047;9717.805643887083;9719.514024298756;9726.416415015121;40181.79909100465;40276.79861600673;40309;40380;40417;3275.967240327614;3317.154125697956;3318.0875259303643;3476.66971637694;3736.4021756518828;30370.392592148255;30797.538036929465;31450.37099258025;31558.526622100686;31657.841710791297;3157.5870763834805;3170.7146356827766;3190.4257233697926;3216.726578240829;3289.490129030004;463735;466082;471669;473162;476958.6152069252;64483.677581611795;65916.67041664857;66056.99999999904;66091.00863487052;66099;36197;37067;68344;68445.3155468449;68793;16772.412965546147;17256.827431725775;17276.481705548853;17282.395116170872;17286.13569321529;13039.956803455701;13107.344632768514;13138.868611313765;13156.407961641558;13179.209247445184;20192.596148076955;20507.58984820325;20571.691424628643;20571.8971405142;20659.69010464844;7627.466077374642;8557.657693692307;8761.29154814805;8868.581027035643;8898.73303800887;846.9576521173917;854.7820305821975;935.5556110847293;1043.8590790243372;1129.5368898751472;29131.126066218047;29687.10938671843;29830.40339193204;29863.104106876828;30178.396432071237;944.9433034017981;1010.3887148275335;1043.410473082706;1110.7334239782556;1127.847740555031;14321.928390358189;14406.639834004234;15350.385984560717;15366.923165384102;15745.44890928812;686176;691540;695086;698389;701194;47129.586112416684;53618.73190634022;54336.45663543393;55353;59183.112253316234;1317.3610798762593;1346.6767975685962;1365.7609918264263;1371.1430356027483;1373.1006190944947;25551.616725748758;28464.43071138524;28671;29380;29921.551176732803;49854;50585;50618.49381506285;50666.24000640067;50707.49292507028;635575;637330;637917;638368;641498;26531;26564.86717566477;27711.72288277172;27790.61046947685;28233.01184458534;46633.76683116562;46770;47135.05729885452;47476.287855681505;47923.76038119787;38175.80912095422;38469.807650961564;38664.45342186394;39792;39872.40191397073;32152.839235803673;38034.23931521299;38529;38641.5667769695;39014.804925975186;36919;37630;38026.239475210896;38209.235815282984;38265.61734382732;30478.085657430314;32130;33404.66595334113;34593.48109778305;34706.479402809484;22447.32658020262;23874.761252387252;25202.36994075163;25356.36609084714;25618.8719056411 13:54:45 INFO - PROCESS | 1980 | |2;jquery.html;363.5074474087611;371.292687430445;371.81223482141513;375.81021584100023;398.9248974015029;19894.701579476303;20354.89822550889;20957.266495672655;20989;21189.364319070413;19856.801431985677;20072.29746958853;20249.69625455616;20319.882406467637;20593;5243.292155558989;5792.623479473821;5981;6067.271927368722;6092.81721548352;5951.226340575719;5970.6119102258435;6007.849803754897;6034.818955431322;6039.788607398742;5663;5941.494972927307;5991.5206783457215;6021.397860213988;6063.545234107438;5795.275590551181;5872.588918775666;5937.821865344046;5993.46058854703;6119.357467465897;5687.744051517691;5693.402192769741;5710.057840456319;5710.800731846317;5729;9190.908090919072;12165.330906800122;12566.623001309976;12976.41606127717;13182.077254592183;2151.580441813847;2318.5826551220775;2420.8426452280546;2745.32739478827;2963.8962636307842;9326.694262803214;9453.763655908588;10099.091081802673;10340.534675939525;10350.275480716353;1887.282832523646;1890.5651700109051;2039.439154232598;2167.7615462299136;2228.955420891573;123979;125636;127760;134220;139030.30484847512;19916.70124948127;20734;20758.48103797387;20760;20945.895270523855;33925.49111763325;34438.65561344405;34571.308573828384;34576.30847383038;34797;10627.681169564925;10661.093807026335;10822.78354432907;10831.566737330577;11090.279131856565;8896.688615898542;8898.06570310121;8929.285657147413;9073.77315567116;9081.909180908238;7722.691092356243;8415.49507029568;8689.6524139035;9486.525673716425;9584.520773961274;3174.96767623315;3347.497875318673;3863.4977452931503;3863.9227215456094;3924.9607503925167;870.9346798990101;886.3839631456206;899.2536194958169;930.1721467893581;962.4465932089076;19394.418167455;20514;20565.794342056688;20599.897000514902;20616.48458788542;929.6235024814825;934.2899396458605;950.7432993091827;956.9760755981156;993.5231089077283;10721.731956701145;11097.44512774358;11110.222284440173;11113.611023614134;11121.888781112248;491262.54368728644;533213;568795;595863;597394;66701;82077;97632.53551196738;106718;112902.74194516228;781.6287263549768;853.3386625365391;958.5973890965811;966.3815158298695;967.4437198610827;16419.753703694216;17483.125843708018;18006.5498362542;18527.722084169018;19000.14499347505;50906;51660.966780663424;51761.48238517567;52783.736081319345;53038.204426932854;65334.67332663306;66902;73080.78748147325;73376.26623733694;74525;5788.8552786179;7474.439417043852;7878.290953814184;7983.481073730189;8153.184681532037;11524;12493.562725304571;12665.787791626732;12754.234745915275;12824.935875320936;10540.736481588021;10644.308119972176;10765.784684306112;10784.784304314027;11063.510710090166;4919.114559379346;7333.899915012577;8875.955620222116;10180.98190180976;11175.273607215506;9019.368644195105;10824.945875270574;10991.120710343313;11395;11808.173427859967;7923.20767923203;8095.959520202597;8120.715774947848;8164.387670924586;8187.918120818716;10188.490575471345;10844.620438284937;10971;11088.944555277172;11231.775364492501 13:54:45 INFO - PROCESS | 1980 | |3;mootools.html;1281.2824818101863;1536.8309485956547;1717.2100833616537;1861.8603604729649;1895.5450691833955;7970.521768693868;8486.405951583383;8640.827183456342;9039.954800225989;9074.001859795426;8674.956625216864;8832.425892316995;8889.68886088987;8900;8909.376343655947;2361.0319768894715;2401.7478164792706;2406.8916898739512;2408.2775167449695;2412.5898597238424;2373.8694371809543;2389.593769059264;2409.915652952147;2410.8312418130736;2419.8185136114776;2386.8806559672034;2389.0563227525117;2399.4841109161525;2401.6757737705448;2409.289259668402;2356.611159158737;2369.39580406996;2374.6794182785275;2376.5128148729555;2382.702162229721;2360.7639236076425;2382.821288403359;2388.904443822245;2389.689340385756;2396.053558844264;8881.822363552692;8927.241184499326;8937.910620893774;8985.415947963362;8996.550172491414;5307.814226502054;5444;5455.372632147274;5457.645253058538;5466.289382380265;3029.560713696502;3633.836477358499;3662.304162209172;3676.8529258829612;3695.9630403696156;1071.844582535528;1081.2377274021796;1082.426314053553;1083.7940791249637;1097.8737445193824;11510.539578416854;11609.477573509212;11687.415629218505;11717.355545444998;11732.648020559482;4736.663369114243;4768.928466073012;4806.279058141306;4902.852914412573;4909.3126962225315;9932.553035113437;10117.645882394081;10127.341722787995;10128.797424051478;10141.746456338651;5444.700541470257;5451.373092094381;5457.945420545744;5460.590455715837;5461.0716178249795;4326.524082350938;4803.231482962709;4956.132676781549;4974.626902982291;5000.89998200034;3395.660433956634;3683.171286460525;3895.3572660511263;3997.200559888034;4101.302778527657;1039.838824982114;1195.946182421793;1229.127319603074;1304.8173255744202;1320.2738493828356;787.7951732549578;841.869510225916;918.2562124679031;945.0738276488942;949.4540639132389;5229.4770522948165;5824.796132135355;5852.502537284294;6007.849803754941;6079.118527813531;444.13172248254585;446.8190382894933;455.462554186057;463.3443677196796;467.7918326344812;3384.1370450534955;3845.115623406632;3909.179072394829;4016.2770701273466;4019.8593049243136;9318.813623727623;10297;10743.24797264184;10770.784584308427;10842.620508282173;10835.729106772395;10835.729106772395;10842.349459032483;10843.403612801372;10871.728206794893;7979.800504987305;8127.431079824474;8284.71003514886;8305.543195124204;8325.042620098646;5680.621510461074;5757.65454072757;5760.510356619734;5774.39368866263;5840.678762668094;8748.431351962103;10166.593336266467;10205.336653117523;10206.846897296398;10256.38461692301;9485.288603354638;10164.491775411348;10352.378857268588;10381.013803688638;10404.323718958243;7431.108267007994;7607.239276072349;7637.961810190914;7666.15672276038;7688.577128258;8265;8329.791755206168;8425.5787210638;8427;8436.493810371398;7375.37309328713;7438.293362130589;7510.780007894461;7517.473776835569;7605.087389513294;7292.48952573336;7371.557706537625;7396.482246242711;7429.44279179053;7448.9627551861895;6967.1291088613925;7044.330788575077;7078.504504684623;7080.114985626797;7084.433245340463;4902.534259245366;4979.203327467588;5006.048850718352;5039.672421292605;5173.0688476074665;4979.950200498093;4997.100521905946;5069.518395752398;5151.768170432265;5250.684958902478 13:54:45 INFO - PROCESS | 1980 | |4;prototype.html;263.390251567621;272.283893360462;314.6098837441573;321.73617633540505;322.8531018386634;4518.977405112974;4846.909445374789;5391.973040134803;5457.781688732446;5504.779808807648;4014.7791871447057;4566.223741963866;5388.7305634718305;5431.402545719968;5443.428440013791;3279.458889283271;4041.7777022263763;4070.979645101785;4139.688249400483;4140.523839758421;3575.9284814303696;4125.958740412602;4141.979290103545;4163.583641635827;4164.10471748574;3699.6300369962923;3875.4574359589537;3948.3879998600264;4120.917581648365;4159.230542349675;3545.5745310562897;3823.7323387362894;4119.8352065917325;4180.703981765662;4185.665146788265;2856.2859285178706;2931.750801181881;3471.194978611108;3569.214772749991;3577.499150118985;4620.422447194101;5161.974190129025;5328.307320048369;5330.9733451332495;5383.488568585978;4573;4743.549362810528;4779.95220047802;4785;4796.968651739892;4974.502549745032;5554.222408862763;5615.494605485526;5654.6041777075625;5749.90751757169;3912.902177445558;3913.5695073542174;3914.921701565981;3923.5880232575455;3927.0771368728324;5283.55089817366;5942.524598032147;6029.125776762345;6106.938930610681;6218.81343559694;3626.456031595229;3926.4895563577124;3975.966248775281;3990.880273591797;3998.8600398986478;4053.7365071270274;4067.1662309226535;4067.511898572131;4075.4294398784195;4082.2039702258367;4516.68024002358;4739.9763001185465;4745.501722319176;4767.4517430495935;4781.450133234723;4971.6271279654175;5561.304836895388;5880.647161170258;5883.676397798076;5897.882042359129;1198.3049831097942;1365.2422905287463;1390.5758743583303;1396.615930619088;1398;784.8430313937235;828.9544075075929;830.8587540118194;846.9110743371981;857.0416598073497;4526.23054080807;5032.018756342478;5108.233764935289;5221.733919296859;5386.057439947994;5234.9476505235225;5504.862378440571;5790.928678194463;5972.820815375546;6026.367231440723;4486.5962063414445;4554.681172317973;4601.746903920316;4700.600448961876;5427.29445172133;3049.557814116941;3081.6147981502313;3137.498000319938;3142.9214269643444;3149.779515433898;4638.12716381825;5257.605679574047;6040.560188261624;6157.630542167484;6215.875682486325;5614.719264036782;5633.464820842013;5755.971220143956;6106.358832322631;6151.72317245725;5147.576861387136;5543.974364742536;5784.843031393738;5946.762129514857;5989.730462129215;5550.500454959073;5613.943860561505;5973.820785376446;5987.101934709828;6055.9091613626715;5292.444293349143;5518.779248830002;5840.459400160944;5903;5945.791897283574;5273.626867909379;6225.750969961151;6256.812295631138;6271.43557079865;6294.402031806971;3082.830444325584;3898.8440462381186;3905.3751399777034;3965.9405108923966;3987.225684570338;4967.850964471072;5951.880962380642;5991.981363168359;5998.790042348497;6011.6994150293185;4837.274408838703;5788.82633520995;5789.652620842763;5835.44563266489;5910.645361278337;4848.466668666514;5174.8965020700125;5223.4515375884985;5604.607677462538;5852.385499522489;5714.885702285847;5738.799142030009;5738.8235411741325;5746.597738158456;5762.740676669476;4593.634278346587;5478.616496845342;5686.9715651421475;5818.44724751148;5828.53371730269;5677.829665110054;5689.004424225661;5713.942860571341;5723.742431590672;5738.393249890038 13:54:45 INFO - PROCESS | 1980 | |5;yui.html;650.3269116464459;719.9136103667561;763.8625047491449;782.2763943352397;803.0443771911423;10902.291351062175;11468.369239691814;11809.586664466724;12842.486300547978;15028.849711502882;14458.987870849045;14509.056911300759;14515.709685806303;14552.199629020399;14595.416183352652;653.1443808610711;697.9197392299874;831.1729828820332;842.3471809347774;871.9912800872005;653.7711800869705;809.6236398123185;827.5146112727638;866.3026263857593;869.9391042627019;881.6730820115749;921.889373275208;924.995375023124;929.0894922975488;929.4516235421135;812.6749300279877;829.98340033199;917.8347897378469;921.6774129054844;926.1433174313801;646.7542333913083;680.3094858718405;692.6605963078106;692.8060143159923;693.6982412650514;14304.57086287413;14515.967764512976;14526.273686315642;14535.636609084857;14541.272936353245;14105.929470352583;14230.573082807532;14322.57032289033;14384.424623015171;14488.71022579553;11614.128940329509;11732.472038758191;11791.317547661589;11828.881711182865;12155.696107597292;3832.6742226910746;3887.9611203888167;3891.571927088018;3999.9800050986814;4013.819378127991;76040;81645.59177204136;108973.45513272462;110296.79406411907;111966;10269.281150319555;10866.945665271624;10930.344179349264;11153.609623663133;11157.888421115847;21472.67790983105;21600.13599456004;21623.891880540497;21649;21687.240946566795;7915.802104947423;8044.029212842891;8063.556504392314;8126.593670316461;8173.918260817316;4284.550122237182;4295.4415925929425;4302.827886884552;4314.072474418015;4316.287812510964;3461.567304086989;3607.7113830893463;3624.257027309395;3625.2386998730035;3720.2745464634136;693.836948317145;698.2703075286338;699.2762490822076;701.431840209432;711.8540699156661;516.8552805214546;651.1096200203745;653.761377097356;661.272600139852;683.5420268420171;7837.686492540234;9330.047053551396;9502;9526.740901441097;9592.95203523992;612.3325575123138;619.3218425823716;638.1990601794718;663.6781161136845;679.58205703492;4358.4769827620885;4609.423822022247;4612.907741845144;4619.260918253063;4638.304254361873;115223;134251.32874335567;135388;155149;158670;85214;96873.51563242139;103280.48359758154;133290;138941;96392;119852.80147198416;121316;121679.39160304141;121737;8594.183552562747;8872.33457490678;8889.4666320021;8928.86606700887;9095.727128186165;61817.58189017167;63005.36994629995;63521.36478635339;63789;64605;62560;91616;92201;93847.06152938383;94496.52751736197;12366.81449778272;12997.935010324887;13141.802872957105;13179.934100329438;13301.866981330062;14558;14841;14841.480548180762;14989.175595342362;15041.849581504483;12927.418266177856;13229.536966206137;13325.333733313102;13894.166350019032;13902;13550.254735989221;13558.79661805054;13785.310734463437;13785.793213101611;14523.360777700542;13398.799018014932;13445.327733613476;13810.309484525935;13826.239556824068;14099.859001409855;10016.1987041038;10238.488075596339;10319;10340.689779306633;11374;9786.736344407118;10424.739381515523;11317.377544235145;11412.258203216765;11581.942090289494 13:54:45 INFO - PROCESS | 1980 | __end_tp_report 13:54:45 INFO - PROCESS | 1980 | __start_cc_report 13:54:45 INFO - PROCESS | 1980 | _x_x_mozilla_cycle_collect,387 13:54:45 INFO - PROCESS | 1980 | __end_cc_report 13:54:45 INFO - PROCESS | 1980 | __startTimestamp1472244885517__endTimestamp 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | ------- Summary: start ------- 13:54:45 INFO - PROCESS | 1980 | Number of tests: 6 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | [#0] dojo.html Cycles:165 Average:5772.06 Median:5931.14 stddev:640.63 (10.8%) stddev-sans-first:615.56 13:54:45 INFO - PROCESS | 1980 | Values: 3424.8 3427.3 3455.1 3458.0 3461.3 4986.3 5485.9 5700.8 5897.6 5923.2 5789.7 5800.6 5900.7 5912.8 5922.4 5208.0 5277.6 5289.8 5364.3 5378.8 5346.2 5356.7 5381.4 5428.8 5458.2 5212.4 5282.6 5307.3 5324.8 5355.5 5266.9 5313.9 5320.9 5323.4 5354.0 5204.7 5239.8 5251.3 5265.2 5317.9 5641.7 5706.8 5786.3 5826.3 5838.3 6208.8 6213.5 6268.2 6273.2 6278.0 5219.3 6225.1 6255.8 6271.8 6274.6 5765.2 5850.6 5886.0 5903.9 5937.7 6429.5 6434.8 6440.3 6456.0 6472.8 5173.5 6209.9 6231.9 6249.8 6254.9 4796.0 6116.3 6156.6 6175.0 6278.2 5213.3 6249.0 6267.8 6271.9 6277.0 5439.9 6235.2 6245.3 6248.9 6264.3 4917.5 4953.9 4984.9 5000.0 5057.7 4478.4 4487.0 4488.6 4509.0 4546.2 5767.9 5896.1 5906.8 5936.6 5966.7 5160.2 6128.1 6215.2 6250.6 6270.4 5844.2 5874.2 5889.6 5897.4 5939.3 5503.2 5503.9 5520.0 5534.7 5538.4 5763.9 6111.0 6316.9 6513.3 6517.5 6223.6 6259.5 6261.4 6266.3 6287.4 6459.5 6526.7 6532.7 6557.5 6571.9 6123.2 6151.5 6189.0 6208.9 6264.4 6234.7 6236.5 6254.6 6257.0 6257.0 6187.3 6197.3 6201.7 6207.8 6211.3 4907.8 6097.4 6113.4 6139.2 6158.1 5925.4 5931.1 6044.4 6061.6 6129.8 6143.0 6186.8 6198.2 6201.6 6228.7 5915.0 5928.3 5973.7 6091.5 6101.3 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | [#1] ext.html Cycles:180 Average:72768.75 Median:40229.30 stddev:163038.02 (405.3%) stddev-sans-first:163405.09 13:54:45 INFO - PROCESS | 1980 | Values: 499.6 504.1 520.9 528.7 536.8 35288.6 38219.8 40455.4 41104.6 41142.8 41723.2 42239.8 42255.8 42268.4 42421.4 9626.9 9832.1 9839.9 9867.4 9900.7 9632.0 9745.3 9763.8 9767.0 9772.0 9723.0 9767.1 9773.5 9798.4 9800.4 9678.4 9731.6 9755.6 9760.6 9770.0 9332.2 9704.9 9717.8 9719.5 9726.4 40181.8 40276.8 40309.0 40380.0 40417.0 3276.0 3317.2 3318.1 3476.7 3736.4 30370.4 30797.5 31450.4 31558.5 31657.8 3157.6 3170.7 3190.4 3216.7 3289.5 463735.0 466082.0 471669.0 473162.0 476958.6 64483.7 65916.7 66057.0 66091.0 66099.0 36197.0 37067.0 68344.0 68445.3 68793.0 16772.4 17256.8 17276.5 17282.4 17286.1 13040.0 13107.3 13138.9 13156.4 13179.2 20192.6 20507.6 20571.7 20571.9 20659.7 7627.5 8557.7 8761.3 8868.6 8898.7 847.0 854.8 935.6 1043.9 1129.5 29131.1 29687.1 29830.4 29863.1 30178.4 944.9 1010.4 1043.4 1110.7 1127.8 14321.9 14406.6 15350.4 15366.9 15745.4 686176.0 691540.0 695086.0 698389.0 701194.0 47129.6 53618.7 54336.5 55353.0 59183.1 1317.4 1346.7 1365.8 1371.1 1373.1 25551.6 28464.4 28671.0 29380.0 29921.6 49854.0 50585.0 50618.5 50666.2 50707.5 635575.0 637330.0 637917.0 638368.0 641498.0 26531.0 26564.9 27711.7 27790.6 28233.0 46633.8 46770.0 47135.1 47476.3 47923.8 38175.8 38469.8 38664.5 39792.0 39872.4 32152.8 38034.2 38529.0 38641.6 39014.8 36919.0 37630.0 38026.2 38209.2 38265.6 30478.1 32130.0 33404.7 34593.5 34706.5 22447.3 23874.8 25202.4 25356.4 25618.9 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | [#2] jquery.html Cycles:180 Average:33576.20 Median:2119.65 stddev:93057.56 (4390.2%) stddev-sans-first:93285.20 13:54:45 INFO - PROCESS | 1980 | Values: 363.5 371.3 371.8 375.8 398.9 19894.7 20354.9 20957.3 20989.0 21189.4 19856.8 20072.3 20249.7 20319.9 20593.0 5243.3 5792.6 5981.0 6067.3 6092.8 5951.2 5970.6 6007.8 6034.8 6039.8 5663.0 5941.5 5991.5 6021.4 6063.5 5795.3 5872.6 5937.8 5993.5 6119.4 5687.7 5693.4 5710.1 5710.8 5729.0 9190.9 12165.3 12566.6 12976.4 13182.1 2151.6 2318.6 2420.8 2745.3 2963.9 9326.7 9453.8 10099.1 10340.5 10350.3 1887.3 1890.6 2039.4 2167.8 2229.0 123979.0 125636.0 127760.0 134220.0 139030.3 19916.7 20734.0 20758.5 20760.0 20945.9 33925.5 34438.7 34571.3 34576.3 34797.0 10627.7 10661.1 10822.8 10831.6 11090.3 8896.7 8898.1 8929.3 9073.8 9081.9 7722.7 8415.5 8689.7 9486.5 9584.5 3175.0 3347.5 3863.5 3863.9 3925.0 870.9 886.4 899.3 930.2 962.4 19394.4 20514.0 20565.8 20599.9 20616.5 929.6 934.3 950.7 957.0 993.5 10721.7 11097.4 11110.2 11113.6 11121.9 491262.5 533213.0 568795.0 595863.0 597394.0 66701.0 82077.0 97632.5 106718.0 112902.7 781.6 853.3 958.6 966.4 967.4 16419.8 17483.1 18006.5 18527.7 19000.1 50906.0 51661.0 51761.5 52783.7 53038.2 65334.7 66902.0 73080.8 73376.3 74525.0 5788.9 7474.4 7878.3 7983.5 8153.2 11524.0 12493.6 12665.8 12754.2 12824.9 10540.7 10644.3 10765.8 10784.8 11063.5 4919.1 7333.9 8876.0 10181.0 11175.3 9019.4 10824.9 10991.1 11395.0 11808.2 7923.2 8096.0 8120.7 8164.4 8187.9 10188.5 10844.6 10971.0 11088.9 11231.8 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | [#3] mootools.html Cycles:180 Average:5728.76 Median:4854.41 stddev:3230.79 (66.6%) stddev-sans-first:3222.56 13:54:45 INFO - PROCESS | 1980 | Values: 1281.3 1536.8 1717.2 1861.9 1895.5 7970.5 8486.4 8640.8 9040.0 9074.0 8675.0 8832.4 8889.7 8900.0 8909.4 2361.0 2401.7 2406.9 2408.3 2412.6 2373.9 2389.6 2409.9 2410.8 2419.8 2386.9 2389.1 2399.5 2401.7 2409.3 2356.6 2369.4 2374.7 2376.5 2382.7 2360.8 2382.8 2388.9 2389.7 2396.1 8881.8 8927.2 8937.9 8985.4 8996.6 5307.8 5444.0 5455.4 5457.6 5466.3 3029.6 3633.8 3662.3 3676.9 3696.0 1071.8 1081.2 1082.4 1083.8 1097.9 11510.5 11609.5 11687.4 11717.4 11732.6 4736.7 4768.9 4806.3 4902.9 4909.3 9932.6 10117.6 10127.3 10128.8 10141.7 5444.7 5451.4 5457.9 5460.6 5461.1 4326.5 4803.2 4956.1 4974.6 5000.9 3395.7 3683.2 3895.4 3997.2 4101.3 1039.8 1195.9 1229.1 1304.8 1320.3 787.8 841.9 918.3 945.1 949.5 5229.5 5824.8 5852.5 6007.8 6079.1 444.1 446.8 455.5 463.3 467.8 3384.1 3845.1 3909.2 4016.3 4019.9 9318.8 10297.0 10743.2 10770.8 10842.6 10835.7 10835.7 10842.3 10843.4 10871.7 7979.8 8127.4 8284.7 8305.5 8325.0 5680.6 5757.7 5760.5 5774.4 5840.7 8748.4 10166.6 10205.3 10206.8 10256.4 9485.3 10164.5 10352.4 10381.0 10404.3 7431.1 7607.2 7638.0 7666.2 7688.6 8265.0 8329.8 8425.6 8427.0 8436.5 7375.4 7438.3 7510.8 7517.5 7605.1 7292.5 7371.6 7396.5 7429.4 7449.0 6967.1 7044.3 7078.5 7080.1 7084.4 4902.5 4979.2 5006.0 5039.7 5173.1 4980.0 4997.1 5069.5 5151.8 5250.7 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | [#4] prototype.html Cycles:180 Average:4617.26 Median:5168.44 stddev:1445.58 (28.0%) stddev-sans-first:1412.22 13:54:45 INFO - PROCESS | 1980 | Values: 263.4 272.3 314.6 321.7 322.9 4519.0 4846.9 5392.0 5457.8 5504.8 4014.8 4566.2 5388.7 5431.4 5443.4 3279.5 4041.8 4071.0 4139.7 4140.5 3575.9 4126.0 4142.0 4163.6 4164.1 3699.6 3875.5 3948.4 4120.9 4159.2 3545.6 3823.7 4119.8 4180.7 4185.7 2856.3 2931.8 3471.2 3569.2 3577.5 4620.4 5162.0 5328.3 5331.0 5383.5 4573.0 4743.5 4780.0 4785.0 4797.0 4974.5 5554.2 5615.5 5654.6 5749.9 3912.9 3913.6 3914.9 3923.6 3927.1 5283.6 5942.5 6029.1 6106.9 6218.8 3626.5 3926.5 3976.0 3990.9 3998.9 4053.7 4067.2 4067.5 4075.4 4082.2 4516.7 4740.0 4745.5 4767.5 4781.5 4971.6 5561.3 5880.6 5883.7 5897.9 1198.3 1365.2 1390.6 1396.6 1398.0 784.8 829.0 830.9 846.9 857.0 4526.2 5032.0 5108.2 5221.7 5386.1 5234.9 5504.9 5790.9 5972.8 6026.4 4486.6 4554.7 4601.7 4700.6 5427.3 3049.6 3081.6 3137.5 3142.9 3149.8 4638.1 5257.6 6040.6 6157.6 6215.9 5614.7 5633.5 5756.0 6106.4 6151.7 5147.6 5544.0 5784.8 5946.8 5989.7 5550.5 5613.9 5973.8 5987.1 6055.9 5292.4 5518.8 5840.5 5903.0 5945.8 5273.6 6225.8 6256.8 6271.4 6294.4 3082.8 3898.8 3905.4 3965.9 3987.2 4967.9 5951.9 5992.0 5998.8 6011.7 4837.3 5788.8 5789.7 5835.4 5910.6 4848.5 5174.9 5223.5 5604.6 5852.4 5714.9 5738.8 5738.8 5746.6 5762.7 4593.6 5478.6 5687.0 5818.4 5828.5 5677.8 5689.0 5713.9 5723.7 5738.4 13:54:45 INFO - PROCESS | 1980 | 13:54:45 INFO - PROCESS | 1980 | [#5] yui.html Cycles:180 Average:23752.13 Median:3889.77 stddev:37542.41 (965.2%) stddev-sans-first:37607.65 13:54:45 INFO - PROCESS | 1980 | Values: 650.3 719.9 763.9 782.3 803.0 10902.3 11468.4 11809.6 12842.5 15028.8 14459.0 14509.1 14515.7 14552.2 14595.4 653.1 697.9 831.2 842.3 872.0 653.8 809.6 827.5 866.3 869.9 881.7 921.9 925.0 929.1 929.5 812.7 830.0 917.8 921.7 926.1 646.8 680.3 692.7 692.8 693.7 14304.6 14516.0 14526.3 14535.6 14541.3 14105.9 14230.6 14322.6 14384.4 14488.7 11614.1 11732.5 11791.3 11828.9 12155.7 3832.7 3888.0 3891.6 4000.0 4013.8 76040.0 81645.6 108973.5 110296.8 111966.0 10269.3 10866.9 10930.3 11153.6 11157.9 21472.7 21600.1 21623.9 21649.0 21687.2 7915.8 8044.0 8063.6 8126.6 8173.9 4284.6 4295.4 4302.8 4314.1 4316.3 3461.6 3607.7 3624.3 3625.2 3720.3 693.8 698.3 699.3 701.4 711.9 516.9 651.1 653.8 661.3 683.5 7837.7 9330.0 9502.0 9526.7 9593.0 612.3 619.3 638.2 663.7 679.6 4358.5 4609.4 4612.9 4619.3 4638.3 115223.0 134251.3 135388.0 155149.0 158670.0 85214.0 96873.5 103280.5 133290.0 138941.0 96392.0 119852.8 121316.0 121679.4 121737.0 8594.2 8872.3 8889.5 8928.9 9095.7 61817.6 63005.4 63521.4 63789.0 64605.0 62560.0 91616.0 92201.0 93847.1 94496.5 12366.8 12997.9 13141.8 13179.9 13301.9 14558.0 14841.0 14841.5 14989.2 15041.8 12927.4 13229.5 13325.3 13894.2 13902.0 13550.3 13558.8 13785.3 13785.8 14523.4 13398.8 13445.3 13810.3 13826.2 14099.9 10016.2 10238.5 10319.0 10340.7 11374.0 9786.7 10424.7 11317.4 11412.3 11581.9 13:54:45 INFO - PROCESS | 1980 | -------- Summary: end -------- 13:54:45 INFO - PROCESS | 1980 | 13:54:46 INFO - TEST-INFO | 1980: exit 0 13:54:46 INFO - TEST-OK | dromaeo_css | took 1114717ms 13:54:46 INFO - TEST-START | kraken 13:54:46 INFO - operating with platform_type : mac_ 13:54:46 INFO - Initialising browser for kraken test... 13:54:46 INFO - TEST-INFO | started process 1986 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpCnzJIr/profile http://localhost:49526/getInfo.html) 13:54:48 INFO - PROCESS | 1986 | __metrics Screen width/height:1600/1200 13:54:48 INFO - PROCESS | 1986 | colorDepth:24 13:54:48 INFO - PROCESS | 1986 | Browser inner width/height: 1024/689 13:54:48 INFO - PROCESS | 1986 | __metrics 13:54:49 ERROR - PROCESS | 1986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:54:49 INFO - TEST-INFO | 1986: exit 0 13:54:49 INFO - Browser initialized. 13:54:49 INFO - Running cycle 1/1 for kraken test... 13:54:49 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpCnzJIr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:01 INFO - PROCESS | 1988 | RSS: Main: 243912704 13:55:01 INFO - PROCESS | 1988 | 13:55:04 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49526/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:05 INFO - PROCESS | 1988 | RSS: Main: 256700416 13:55:05 INFO - PROCESS | 1988 | 13:55:08 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49526/tests/kraken/driver.html?testName=audio-dft) 13:55:09 INFO - PROCESS | 1988 | RSS: Main: 265334784 13:55:09 INFO - PROCESS | 1988 | 13:55:12 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49526/tests/kraken/driver.html?testName=audio-fft) 13:55:13 INFO - PROCESS | 1988 | RSS: Main: 264110080 13:55:13 INFO - PROCESS | 1988 | 13:55:15 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49526/tests/kraken/driver.html?testName=audio-oscillator) 13:55:15 INFO - PROCESS | 1988 | RSS: Main: 267075584 13:55:15 INFO - PROCESS | 1988 | 13:55:18 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:55:18 INFO - PROCESS | 1988 | RSS: Main: 266891264 13:55:18 INFO - PROCESS | 1988 | 13:55:21 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49526/tests/kraken/driver.html?testName=imaging-darkroom) 13:55:22 INFO - PROCESS | 1988 | RSS: Main: 267100160 13:55:22 INFO - PROCESS | 1988 | 13:55:24 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49526/tests/kraken/driver.html?testName=imaging-desaturate) 13:55:25 INFO - PROCESS | 1988 | RSS: Main: 267440128 13:55:25 INFO - PROCESS | 1988 | 13:55:28 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49526/tests/kraken/driver.html?testName=json-parse-financial) 13:55:29 INFO - PROCESS | 1988 | RSS: Main: 267677696 13:55:29 INFO - PROCESS | 1988 | 13:55:30 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:55:31 INFO - PROCESS | 1988 | RSS: Main: 267284480 13:55:31 INFO - PROCESS | 1988 | 13:55:33 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:55:34 INFO - PROCESS | 1988 | RSS: Main: 267464704 13:55:34 INFO - PROCESS | 1988 | 13:55:36 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:55:37 INFO - PROCESS | 1988 | RSS: Main: 267730944 13:55:37 INFO - PROCESS | 1988 | 13:55:39 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:55:40 INFO - PROCESS | 1988 | RSS: Main: 267948032 13:55:40 INFO - PROCESS | 1988 | 13:55:43 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:55:44 INFO - PROCESS | 1988 | RSS: Main: 268075008 13:55:44 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49526/tests/kraken/driver.html?testName=ai-astar) 13:55:46 INFO - PROCESS | 1988 | RSS: Main: 270065664 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | __start_tp_report 13:55:46 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 13:55:46 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 13:55:46 INFO - PROCESS | 1988 | |i|pagename|runs| 13:55:46 INFO - PROCESS | 1988 | |0;ai-astar;112;113;131;104;154;177;170;117;116;139 13:55:46 INFO - PROCESS | 1988 | |1;audio-beat-detection;142;108;164;150;131;166;122;146;203;99 13:55:46 INFO - PROCESS | 1988 | |2;audio-dft;209;242;283;191;273;280;196;204;184;268 13:55:46 INFO - PROCESS | 1988 | |3;audio-fft;71;83;77;147;59;59;60;67;138;57 13:55:46 INFO - PROCESS | 1988 | |4;audio-oscillator;70;72;118;71;74;85;137;102;106;117 13:55:46 INFO - PROCESS | 1988 | |5;imaging-gaussian-blur;89;86;88;86;89;85;88;86;88;85 13:55:46 INFO - PROCESS | 1988 | |6;imaging-darkroom;168;99;96;98;97;99;98;98;108;100 13:55:46 INFO - PROCESS | 1988 | |7;imaging-desaturate;150;148;90;91;108;126;91;92;91;91 13:55:46 INFO - PROCESS | 1988 | |8;json-parse-financial;57;58;57;57;58;57;56;57;58;56 13:55:46 INFO - PROCESS | 1988 | |9;json-stringify-tinderbox;68;67;72;103;105;116;79;67;68;71 13:55:46 INFO - PROCESS | 1988 | |10;stanford-crypto-aes;99;87;89;89;89;86;86;86;90;85 13:55:46 INFO - PROCESS | 1988 | |11;stanford-crypto-ccm;140;139;137;137;144;132;142;167;198;163 13:55:46 INFO - PROCESS | 1988 | |12;stanford-crypto-pbkdf2;172;187;239;213;173;178;173;170;170;177 13:55:46 INFO - PROCESS | 1988 | |13;stanford-crypto-sha256-iterative;68;71;66;61;62;72;83;92;64;74 13:55:46 INFO - PROCESS | 1988 | __end_tp_report 13:55:46 INFO - PROCESS | 1988 | __start_cc_report 13:55:46 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,971 13:55:46 INFO - PROCESS | 1988 | __end_cc_report 13:55:46 INFO - PROCESS | 1988 | __startTimestamp1472244946255__endTimestamp 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | ------- Summary: start ------- 13:55:46 INFO - PROCESS | 1988 | Number of tests: 14 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#0] ai-astar Cycles:10 Average:133.30 Median:135.00 stddev:25.85 (19.1%) stddev-sans-first:26.24 13:55:46 INFO - PROCESS | 1988 | Values: 112.0 113.0 131.0 104.0 154.0 177.0 170.0 117.0 116.0 139.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:157.00 stddev:30.50 (19.4%) stddev-sans-first:32.35 13:55:46 INFO - PROCESS | 1988 | Values: 142.0 108.0 164.0 150.0 131.0 166.0 122.0 146.0 203.0 99.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#2] audio-dft Cycles:10 Average:233.00 Median:255.00 stddev:40.23 (15.8%) stddev-sans-first:41.72 13:55:46 INFO - PROCESS | 1988 | Values: 209.0 242.0 283.0 191.0 273.0 280.0 196.0 204.0 184.0 268.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#3] audio-fft Cycles:10 Average:81.80 Median:63.50 stddev:33.17 (52.2%) stddev-sans-first:34.95 13:55:46 INFO - PROCESS | 1988 | Values: 71.0 83.0 77.0 147.0 59.0 59.0 60.0 67.0 138.0 57.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:70.50 stddev:24.08 (34.2%) stddev-sans-first:23.75 13:55:46 INFO - PROCESS | 1988 | Values: 70.0 72.0 118.0 71.0 74.0 85.0 137.0 102.0 106.0 117.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.56 (1.8%) stddev-sans-first:1.48 13:55:46 INFO - PROCESS | 1988 | Values: 89.0 86.0 88.0 86.0 89.0 85.0 88.0 86.0 88.0 85.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:98.00 stddev:22.00 (22.4%) stddev-sans-first:3.49 13:55:46 INFO - PROCESS | 1988 | Values: 168.0 99.0 96.0 98.0 97.0 99.0 98.0 98.0 108.0 100.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:91.00 stddev:24.55 (27.0%) stddev-sans-first:20.75 13:55:46 INFO - PROCESS | 1988 | Values: 150.0 148.0 90.0 91.0 108.0 126.0 91.0 92.0 91.0 91.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 13:55:46 INFO - PROCESS | 1988 | Values: 57.0 58.0 57.0 57.0 58.0 57.0 56.0 57.0 58.0 56.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#9] json-stringify-tinderbox Cycles:10 Average:81.60 Median:68.00 stddev:18.85 (27.7%) stddev-sans-first:19.34 13:55:46 INFO - PROCESS | 1988 | Values: 68.0 67.0 72.0 103.0 105.0 116.0 79.0 67.0 68.0 71.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:89.00 stddev:4.03 (4.5%) stddev-sans-first:1.81 13:55:46 INFO - PROCESS | 1988 | Values: 99.0 87.0 89.0 89.0 89.0 86.0 86.0 86.0 90.0 85.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:143.00 stddev:20.40 (14.3%) stddev-sans-first:21.32 13:55:46 INFO - PROCESS | 1988 | Values: 140.0 139.0 137.0 137.0 144.0 132.0 142.0 167.0 198.0 163.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:177.50 stddev:22.91 (12.9%) stddev-sans-first:23.80 13:55:46 INFO - PROCESS | 1988 | Values: 172.0 187.0 239.0 213.0 173.0 178.0 173.0 170.0 170.0 177.0 13:55:46 INFO - PROCESS | 1988 | 13:55:46 INFO - PROCESS | 1988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:9.76 (13.7%) stddev-sans-first:10.28 13:55:46 INFO - PROCESS | 1988 | Values: 68.0 71.0 66.0 61.0 62.0 72.0 83.0 92.0 64.0 74.0 13:55:46 INFO - PROCESS | 1988 | -------- Summary: end -------- 13:55:46 INFO - PROCESS | 1988 | 13:55:47 INFO - TEST-INFO | 1988: exit 0 13:55:47 INFO - TEST-OK | kraken | took 60909ms 13:55:47 INFO - SUITE-END | took 1175s 13:55:47 INFO - Completed test suite (00:19:35) 13:55:47 INFO - javascript benchmark 13:55:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7415.159443368463, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.79451232926, 3427.28027114306, 3455.118944669109, 3458.0, 3461.325041616884, 4986.252062190673, 5485.945140548593, 5700.800471983482, 5897.587168898179, 5923.229980102591, 5789.739461724222, 5800.622959507629, 5900.704964751767, 5912.763489460427, 5922.407759224076, 5208.0, 5277.604179686519, 5289.814856480024, 5364.275822763935, 5378.784848606051, 5346.171343441753, 5356.7321633918145, 5381.408045115034, 5428.83713488594, 5458.235846981426, 5212.40057393397, 5282.550983166436, 5307.2569840222395, 5324.787008519655, 5355.544778693816, 5266.8683282917855, 5313.867153321159, 5320.920186197211, 5323.387810401815, 5353.9732301338245, 5204.739763011834, 5239.764210610531, 5251.343582052244, 5265.210218467222, 5317.867053323659, 5641.71791410432, 5706.77172913083, 5786.276715410574, 5826.329972053183, 5838.299404071496, 6208.751649933997, 6213.471854892339, 6268.15379923709, 6273.184486016834, 6277.968610156966, 5219.321488206547, 6225.087691326506, 6255.781047663356, 6271.78048768291, 6274.623522588659, 5765.164051212634, 5850.590458667937, 5886.0, 5903.940960590425, 5937.732802023919, 6429.54993150475, 6434.8391290218115, 6440.25937017249, 6456.0, 6472.805815825533, 5173.4826517347965, 6209.9068513972325, 6231.875362492725, 6249.75000999964, 6254.937450625526, 4795.976020119947, 6116.33577150815, 6156.5998210116195, 6174.969125154345, 6278.183836101278, 5213.296205012351, 6248.968755156195, 6267.780627678009, 6271.937280627227, 6277.0, 5439.891202175934, 6235.220597425322, 6245.28179259391, 6248.906441372833, 6264.2796078451565, 4917.508249175054, 4953.925691114636, 4984.90030199394, 5000.049990501793, 5057.72182529957, 4478.440194975628, 4486.955130448719, 4488.551144885485, 4508.954910450919, 4546.204414227563, 5767.8558036049435, 5896.1450589664255, 5906.793262235801, 5936.5844390892225, 5966.701664916824, 5160.20016897374, 6128.050152226412, 6215.160953271341, 6250.624962502174, 6270.435660790459, 5844.211031510777, 5874.236349274653, 5889.587728858939, 5897.351291357947, 5939.287285525765, 5503.229547863302, 5503.9174412383845, 5520.0, 5534.695591742412, 5538.418466061086, 5763.913541296968, 6111.022236442326, 6316.873662526816, 6513.316101809337, 6517.511186661114, 6223.626582405071, 6259.467945224706, 6261.405166509175, 6266.342034086355, 6287.371262873676, 6459.515536334888, 6526.738930442919, 6532.673366331569, 6557.475401967736, 6571.934280657323, 6123.160610921377, 6151.50787936955, 6189.0, 6208.906866397098, 6264.373562643699, 6234.719437625408, 6236.501079913505, 6254.593451425642, 6256.968715156395, 6257.0, 6187.319394866651, 6197.318294987457, 6201.6899155041165, 6207.81376558704, 6211.254649442096, 4907.828226012215, 6097.359777223328, 6113.419225173601, 6139.154842350836, 6158.137860699595, 5925.40745925404, 5931.1399847021075, 6044.395560443921, 6061.605995610271, 6129.8467538310115, 6142.969285153546, 6186.783462578788, 6198.2252218472695, 6201.596896201732, 6228.688565571794, 5914.970425147847, 5928.347881733092, 5973.731182096903, 6091.5126789857595, 6101.267847858107], "value": 5734.910780093488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.5828483216515, 504.0649595001275, 520.8749900023994, 528.7462018231251, 536.8094326514088, 35288.64711352889, 38219.80890095549, 40455.393169102485, 41104.588954110484, 41142.794286028606, 41723.165536689325, 42239.78880105603, 42255.78872105643, 42268.36597451041, 42421.36367954483, 9626.855597166048, 9832.115109640132, 9839.90160098397, 9867.358621689604, 9900.702978910644, 9631.951840240788, 9745.31782775206, 9763.804723905518, 9767.0, 9772.0, 9723.02769723029, 9767.120959113678, 9773.511324433786, 9798.363106398061, 9800.362976406546, 9678.419294842262, 9731.610735570604, 9755.609775609038, 9760.609575616967, 9769.951150244238, 9332.206762425201, 9704.90295097047, 9717.805643887083, 9719.514024298756, 9726.416415015121, 40181.79909100465, 40276.79861600673, 40309.0, 40380.0, 40417.0, 3275.967240327614, 3317.154125697956, 3318.0875259303643, 3476.66971637694, 3736.4021756518828, 30370.392592148255, 30797.538036929465, 31450.37099258025, 31558.526622100686, 31657.841710791297, 3157.5870763834805, 3170.7146356827766, 3190.4257233697926, 3216.726578240829, 3289.490129030004, 463735.0, 466082.0, 471669.0, 473162.0, 476958.6152069252, 64483.677581611795, 65916.67041664857, 66056.99999999904, 66091.00863487052, 66099.0, 36197.0, 37067.0, 68344.0, 68445.3155468449, 68793.0, 16772.412965546147, 17256.827431725775, 17276.481705548853, 17282.395116170872, 17286.13569321529, 13039.956803455701, 13107.344632768514, 13138.868611313765, 13156.407961641558, 13179.209247445184, 20192.596148076955, 20507.58984820325, 20571.691424628643, 20571.8971405142, 20659.69010464844, 7627.466077374642, 8557.657693692307, 8761.29154814805, 8868.581027035643, 8898.73303800887, 846.9576521173917, 854.7820305821975, 935.5556110847293, 1043.8590790243372, 1129.5368898751472, 29131.126066218047, 29687.10938671843, 29830.40339193204, 29863.104106876828, 30178.396432071237, 944.9433034017981, 1010.3887148275335, 1043.410473082706, 1110.7334239782556, 1127.847740555031, 14321.928390358189, 14406.639834004234, 15350.385984560717, 15366.923165384102, 15745.44890928812, 686176.0, 691540.0, 695086.0, 698389.0, 701194.0, 47129.586112416684, 53618.73190634022, 54336.45663543393, 55353.0, 59183.112253316234, 1317.3610798762593, 1346.6767975685962, 1365.7609918264263, 1371.1430356027483, 1373.1006190944947, 25551.616725748758, 28464.43071138524, 28671.0, 29380.0, 29921.551176732803, 49854.0, 50585.0, 50618.49381506285, 50666.24000640067, 50707.49292507028, 635575.0, 637330.0, 637917.0, 638368.0, 641498.0, 26531.0, 26564.86717566477, 27711.72288277172, 27790.61046947685, 28233.01184458534, 46633.76683116562, 46770.0, 47135.05729885452, 47476.287855681505, 47923.76038119787, 38175.80912095422, 38469.807650961564, 38664.45342186394, 39792.0, 39872.40191397073, 32152.839235803673, 38034.23931521299, 38529.0, 38641.5667769695, 39014.804925975186, 36919.0, 37630.0, 38026.239475210896, 38209.235815282984, 38265.61734382732, 30478.085657430314, 32130.0, 33404.66595334113, 34593.48109778305, 34706.479402809484, 22447.32658020262, 23874.761252387252, 25202.36994075163, 25356.36609084714, 25618.8719056411], "value": 20120.208292970776, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.5074474087611, 371.292687430445, 371.81223482141513, 375.81021584100023, 398.9248974015029, 19894.701579476303, 20354.89822550889, 20957.266495672655, 20989.0, 21189.364319070413, 19856.801431985677, 20072.29746958853, 20249.69625455616, 20319.882406467637, 20593.0, 5243.292155558989, 5792.623479473821, 5981.0, 6067.271927368722, 6092.81721548352, 5951.226340575719, 5970.6119102258435, 6007.849803754897, 6034.818955431322, 6039.788607398742, 5663.0, 5941.494972927307, 5991.5206783457215, 6021.397860213988, 6063.545234107438, 5795.275590551181, 5872.588918775666, 5937.821865344046, 5993.46058854703, 6119.357467465897, 5687.744051517691, 5693.402192769741, 5710.057840456319, 5710.800731846317, 5729.0, 9190.908090919072, 12165.330906800122, 12566.623001309976, 12976.41606127717, 13182.077254592183, 2151.580441813847, 2318.5826551220775, 2420.8426452280546, 2745.32739478827, 2963.8962636307842, 9326.694262803214, 9453.763655908588, 10099.091081802673, 10340.534675939525, 10350.275480716353, 1887.282832523646, 1890.5651700109051, 2039.439154232598, 2167.7615462299136, 2228.955420891573, 123979.0, 125636.0, 127760.0, 134220.0, 139030.30484847512, 19916.70124948127, 20734.0, 20758.48103797387, 20760.0, 20945.895270523855, 33925.49111763325, 34438.65561344405, 34571.308573828384, 34576.30847383038, 34797.0, 10627.681169564925, 10661.093807026335, 10822.78354432907, 10831.566737330577, 11090.279131856565, 8896.688615898542, 8898.06570310121, 8929.285657147413, 9073.77315567116, 9081.909180908238, 7722.691092356243, 8415.49507029568, 8689.6524139035, 9486.525673716425, 9584.520773961274, 3174.96767623315, 3347.497875318673, 3863.4977452931503, 3863.9227215456094, 3924.9607503925167, 870.9346798990101, 886.3839631456206, 899.2536194958169, 930.1721467893581, 962.4465932089076, 19394.418167455, 20514.0, 20565.794342056688, 20599.897000514902, 20616.48458788542, 929.6235024814825, 934.2899396458605, 950.7432993091827, 956.9760755981156, 993.5231089077283, 10721.731956701145, 11097.44512774358, 11110.222284440173, 11113.611023614134, 11121.888781112248, 491262.54368728644, 533213.0, 568795.0, 595863.0, 597394.0, 66701.0, 82077.0, 97632.53551196738, 106718.0, 112902.74194516228, 781.6287263549768, 853.3386625365391, 958.5973890965811, 966.3815158298695, 967.4437198610827, 16419.753703694216, 17483.125843708018, 18006.5498362542, 18527.722084169018, 19000.14499347505, 50906.0, 51660.966780663424, 51761.48238517567, 52783.736081319345, 53038.204426932854, 65334.67332663306, 66902.0, 73080.78748147325, 73376.26623733694, 74525.0, 5788.8552786179, 7474.439417043852, 7878.290953814184, 7983.481073730189, 8153.184681532037, 11524.0, 12493.562725304571, 12665.787791626732, 12754.234745915275, 12824.935875320936, 10540.736481588021, 10644.308119972176, 10765.784684306112, 10784.784304314027, 11063.510710090166, 4919.114559379346, 7333.899915012577, 8875.955620222116, 10180.98190180976, 11175.273607215506, 9019.368644195105, 10824.945875270574, 10991.120710343313, 11395.0, 11808.173427859967, 7923.20767923203, 8095.959520202597, 8120.715774947848, 8164.387670924586, 8187.918120818716, 10188.490575471345, 10844.620438284937, 10971.0, 11088.944555277172, 11231.775364492501], "value": 9986.151089182988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.2824818101863, 1536.8309485956547, 1717.2100833616537, 1861.8603604729649, 1895.5450691833955, 7970.521768693868, 8486.405951583383, 8640.827183456342, 9039.954800225989, 9074.001859795426, 8674.956625216864, 8832.425892316995, 8889.68886088987, 8900.0, 8909.376343655947, 2361.0319768894715, 2401.7478164792706, 2406.8916898739512, 2408.2775167449695, 2412.5898597238424, 2373.8694371809543, 2389.593769059264, 2409.915652952147, 2410.8312418130736, 2419.8185136114776, 2386.8806559672034, 2389.0563227525117, 2399.4841109161525, 2401.6757737705448, 2409.289259668402, 2356.611159158737, 2369.39580406996, 2374.6794182785275, 2376.5128148729555, 2382.702162229721, 2360.7639236076425, 2382.821288403359, 2388.904443822245, 2389.689340385756, 2396.053558844264, 8881.822363552692, 8927.241184499326, 8937.910620893774, 8985.415947963362, 8996.550172491414, 5307.814226502054, 5444.0, 5455.372632147274, 5457.645253058538, 5466.289382380265, 3029.560713696502, 3633.836477358499, 3662.304162209172, 3676.8529258829612, 3695.9630403696156, 1071.844582535528, 1081.2377274021796, 1082.426314053553, 1083.7940791249637, 1097.8737445193824, 11510.539578416854, 11609.477573509212, 11687.415629218505, 11717.355545444998, 11732.648020559482, 4736.663369114243, 4768.928466073012, 4806.279058141306, 4902.852914412573, 4909.3126962225315, 9932.553035113437, 10117.645882394081, 10127.341722787995, 10128.797424051478, 10141.746456338651, 5444.700541470257, 5451.373092094381, 5457.945420545744, 5460.590455715837, 5461.0716178249795, 4326.524082350938, 4803.231482962709, 4956.132676781549, 4974.626902982291, 5000.89998200034, 3395.660433956634, 3683.171286460525, 3895.3572660511263, 3997.200559888034, 4101.302778527657, 1039.838824982114, 1195.946182421793, 1229.127319603074, 1304.8173255744202, 1320.2738493828356, 787.7951732549578, 841.869510225916, 918.2562124679031, 945.0738276488942, 949.4540639132389, 5229.4770522948165, 5824.796132135355, 5852.502537284294, 6007.849803754941, 6079.118527813531, 444.13172248254585, 446.8190382894933, 455.462554186057, 463.3443677196796, 467.7918326344812, 3384.1370450534955, 3845.115623406632, 3909.179072394829, 4016.2770701273466, 4019.8593049243136, 9318.813623727623, 10297.0, 10743.24797264184, 10770.784584308427, 10842.620508282173, 10835.729106772395, 10835.729106772395, 10842.349459032483, 10843.403612801372, 10871.728206794893, 7979.800504987305, 8127.431079824474, 8284.71003514886, 8305.543195124204, 8325.042620098646, 5680.621510461074, 5757.65454072757, 5760.510356619734, 5774.39368866263, 5840.678762668094, 8748.431351962103, 10166.593336266467, 10205.336653117523, 10206.846897296398, 10256.38461692301, 9485.288603354638, 10164.491775411348, 10352.378857268588, 10381.013803688638, 10404.323718958243, 7431.108267007994, 7607.239276072349, 7637.961810190914, 7666.15672276038, 7688.577128258, 8265.0, 8329.791755206168, 8425.5787210638, 8427.0, 8436.493810371398, 7375.37309328713, 7438.293362130589, 7510.780007894461, 7517.473776835569, 7605.087389513294, 7292.48952573336, 7371.557706537625, 7396.482246242711, 7429.44279179053, 7448.9627551861895, 6967.1291088613925, 7044.330788575077, 7078.504504684623, 7080.114985626797, 7084.433245340463, 4902.534259245366, 4979.203327467588, 5006.048850718352, 5039.672421292605, 5173.0688476074665, 4979.950200498093, 4997.100521905946, 5069.518395752398, 5151.768170432265, 5250.684958902478], "value": 4522.522961481676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.390251567621, 272.283893360462, 314.6098837441573, 321.73617633540505, 322.8531018386634, 4518.977405112974, 4846.909445374789, 5391.973040134803, 5457.781688732446, 5504.779808807648, 4014.7791871447057, 4566.223741963866, 5388.7305634718305, 5431.402545719968, 5443.428440013791, 3279.458889283271, 4041.7777022263763, 4070.979645101785, 4139.688249400483, 4140.523839758421, 3575.9284814303696, 4125.958740412602, 4141.979290103545, 4163.583641635827, 4164.10471748574, 3699.6300369962923, 3875.4574359589537, 3948.3879998600264, 4120.917581648365, 4159.230542349675, 3545.5745310562897, 3823.7323387362894, 4119.8352065917325, 4180.703981765662, 4185.665146788265, 2856.2859285178706, 2931.750801181881, 3471.194978611108, 3569.214772749991, 3577.499150118985, 4620.422447194101, 5161.974190129025, 5328.307320048369, 5330.9733451332495, 5383.488568585978, 4573.0, 4743.549362810528, 4779.95220047802, 4785.0, 4796.968651739892, 4974.502549745032, 5554.222408862763, 5615.494605485526, 5654.6041777075625, 5749.90751757169, 3912.902177445558, 3913.5695073542174, 3914.921701565981, 3923.5880232575455, 3927.0771368728324, 5283.55089817366, 5942.524598032147, 6029.125776762345, 6106.938930610681, 6218.81343559694, 3626.456031595229, 3926.4895563577124, 3975.966248775281, 3990.880273591797, 3998.8600398986478, 4053.7365071270274, 4067.1662309226535, 4067.511898572131, 4075.4294398784195, 4082.2039702258367, 4516.68024002358, 4739.9763001185465, 4745.501722319176, 4767.4517430495935, 4781.450133234723, 4971.6271279654175, 5561.304836895388, 5880.647161170258, 5883.676397798076, 5897.882042359129, 1198.3049831097942, 1365.2422905287463, 1390.5758743583303, 1396.615930619088, 1398.0, 784.8430313937235, 828.9544075075929, 830.8587540118194, 846.9110743371981, 857.0416598073497, 4526.23054080807, 5032.018756342478, 5108.233764935289, 5221.733919296859, 5386.057439947994, 5234.9476505235225, 5504.862378440571, 5790.928678194463, 5972.820815375546, 6026.367231440723, 4486.5962063414445, 4554.681172317973, 4601.746903920316, 4700.600448961876, 5427.29445172133, 3049.557814116941, 3081.6147981502313, 3137.498000319938, 3142.9214269643444, 3149.779515433898, 4638.12716381825, 5257.605679574047, 6040.560188261624, 6157.630542167484, 6215.875682486325, 5614.719264036782, 5633.464820842013, 5755.971220143956, 6106.358832322631, 6151.72317245725, 5147.576861387136, 5543.974364742536, 5784.843031393738, 5946.762129514857, 5989.730462129215, 5550.500454959073, 5613.943860561505, 5973.820785376446, 5987.101934709828, 6055.9091613626715, 5292.444293349143, 5518.779248830002, 5840.459400160944, 5903.0, 5945.791897283574, 5273.626867909379, 6225.750969961151, 6256.812295631138, 6271.43557079865, 6294.402031806971, 3082.830444325584, 3898.8440462381186, 3905.3751399777034, 3965.9405108923966, 3987.225684570338, 4967.850964471072, 5951.880962380642, 5991.981363168359, 5998.790042348497, 6011.6994150293185, 4837.274408838703, 5788.82633520995, 5789.652620842763, 5835.44563266489, 5910.645361278337, 4848.466668666514, 5174.8965020700125, 5223.4515375884985, 5604.607677462538, 5852.385499522489, 5714.885702285847, 5738.799142030009, 5738.8235411741325, 5746.597738158456, 5762.740676669476, 4593.634278346587, 5478.616496845342, 5686.9715651421475, 5818.44724751148, 5828.53371730269, 5677.829665110054, 5689.004424225661, 5713.942860571341, 5723.742431590672, 5738.393249890038], "value": 4149.572589269175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.3269116464459, 719.9136103667561, 763.8625047491449, 782.2763943352397, 803.0443771911423, 10902.291351062175, 11468.369239691814, 11809.586664466724, 12842.486300547978, 15028.849711502882, 14458.987870849045, 14509.056911300759, 14515.709685806303, 14552.199629020399, 14595.416183352652, 653.1443808610711, 697.9197392299874, 831.1729828820332, 842.3471809347774, 871.9912800872005, 653.7711800869705, 809.6236398123185, 827.5146112727638, 866.3026263857593, 869.9391042627019, 881.6730820115749, 921.889373275208, 924.995375023124, 929.0894922975488, 929.4516235421135, 812.6749300279877, 829.98340033199, 917.8347897378469, 921.6774129054844, 926.1433174313801, 646.7542333913083, 680.3094858718405, 692.6605963078106, 692.8060143159923, 693.6982412650514, 14304.57086287413, 14515.967764512976, 14526.273686315642, 14535.636609084857, 14541.272936353245, 14105.929470352583, 14230.573082807532, 14322.57032289033, 14384.424623015171, 14488.71022579553, 11614.128940329509, 11732.472038758191, 11791.317547661589, 11828.881711182865, 12155.696107597292, 3832.6742226910746, 3887.9611203888167, 3891.571927088018, 3999.9800050986814, 4013.819378127991, 76040.0, 81645.59177204136, 108973.45513272462, 110296.79406411907, 111966.0, 10269.281150319555, 10866.945665271624, 10930.344179349264, 11153.609623663133, 11157.888421115847, 21472.67790983105, 21600.13599456004, 21623.891880540497, 21649.0, 21687.240946566795, 7915.802104947423, 8044.029212842891, 8063.556504392314, 8126.593670316461, 8173.918260817316, 4284.550122237182, 4295.4415925929425, 4302.827886884552, 4314.072474418015, 4316.287812510964, 3461.567304086989, 3607.7113830893463, 3624.257027309395, 3625.2386998730035, 3720.2745464634136, 693.836948317145, 698.2703075286338, 699.2762490822076, 701.431840209432, 711.8540699156661, 516.8552805214546, 651.1096200203745, 653.761377097356, 661.272600139852, 683.5420268420171, 7837.686492540234, 9330.047053551396, 9502.0, 9526.740901441097, 9592.95203523992, 612.3325575123138, 619.3218425823716, 638.1990601794718, 663.6781161136845, 679.58205703492, 4358.4769827620885, 4609.423822022247, 4612.907741845144, 4619.260918253063, 4638.304254361873, 115223.0, 134251.32874335567, 135388.0, 155149.0, 158670.0, 85214.0, 96873.51563242139, 103280.48359758154, 133290.0, 138941.0, 96392.0, 119852.80147198416, 121316.0, 121679.39160304141, 121737.0, 8594.183552562747, 8872.33457490678, 8889.4666320021, 8928.86606700887, 9095.727128186165, 61817.58189017167, 63005.36994629995, 63521.36478635339, 63789.0, 64605.0, 62560.0, 91616.0, 92201.0, 93847.06152938383, 94496.52751736197, 12366.81449778272, 12997.935010324887, 13141.802872957105, 13179.934100329438, 13301.866981330062, 14558.0, 14841.0, 14841.480548180762, 14989.175595342362, 15041.849581504483, 12927.418266177856, 13229.536966206137, 13325.333733313102, 13894.166350019032, 13902.0, 13550.254735989221, 13558.79661805054, 13785.310734463437, 13785.793213101611, 14523.360777700542, 13398.799018014932, 13445.327733613476, 13810.309484525935, 13826.239556824068, 14099.859001409855, 10016.1987041038, 10238.488075596339, 10319.0, 10340.689779306633, 11374.0, 9786.736344407118, 10424.739381515523, 11317.377544235145, 11412.258203216765, 11581.942090289494], "value": 7686.612297603321, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1620.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 131.0, 104.0, 154.0, 177.0, 170.0, 117.0, 116.0, 139.0], "value": 133.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 164.0, 150.0, 131.0, 166.0, 122.0, 146.0, 203.0, 99.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 242.0, 283.0, 191.0, 273.0, 280.0, 196.0, 204.0, 184.0, 268.0], "value": 233.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 77.0, 147.0, 59.0, 59.0, 60.0, 67.0, 138.0, 57.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 118.0, 71.0, 74.0, 85.0, 137.0, 102.0, 106.0, 117.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 89.0, 85.0, 88.0, 86.0, 88.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 99.0, 96.0, 98.0, 97.0, 99.0, 98.0, 98.0, 108.0, 100.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 90.0, 91.0, 108.0, 126.0, 91.0, 92.0, 91.0, 91.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 58.0, 57.0, 56.0, 57.0, 58.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 72.0, 103.0, 105.0, 116.0, 79.0, 67.0, 68.0, 71.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 87.0, 89.0, 89.0, 89.0, 86.0, 86.0, 86.0, 90.0, 85.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 137.0, 137.0, 144.0, 132.0, 142.0, 167.0, 198.0, 163.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 187.0, 239.0, 213.0, 173.0, 178.0, 173.0, 170.0, 170.0, 177.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 66.0, 61.0, 62.0, 72.0, 83.0, 92.0, 64.0, 74.0], "value": 71.3, "unit": "score"}]}]} 13:55:47 INFO - Return code: 0 13:55:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:55:47 ERROR - # TBPL SUCCESS # 13:55:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:55:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:55:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:55:47 INFO - 2016-08-26 13:55:47.597 screenresolution[1993:16857] starting screenresolution argv=screenresolution get 13:55:47 INFO - 2016-08-26 13:55:47.600 screenresolution[1993:16857] Display 0: 1600x1200x32@60 13:55:47 INFO - 2016-08-26 13:55:47.606 screenresolution[1994:16860] starting screenresolution argv=screenresolution list 13:55:47 INFO - Available Modes on Display 0 13:55:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:55:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:55:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:55:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:55:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:55:47 INFO - Intel Iris: 13:55:47 INFO - Chipset Model: Intel Iris 13:55:47 INFO - Type: GPU 13:55:47 INFO - Bus: Built-In 13:55:47 INFO - VRAM (Dynamic, Max): 1536 MB 13:55:47 INFO - Vendor: Intel (0x8086) 13:55:47 INFO - Device ID: 0x0a2e 13:55:47 INFO - Revision ID: 0x0009 13:55:47 INFO - Displays: 13:55:47 INFO - Display: 13:55:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:55:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:55:47 INFO - Display Serial Number: 1600x1200 60 13:55:47 INFO - Main Display: Yes 13:55:47 INFO - Mirror: Off 13:55:47 INFO - Online: Yes 13:55:47 INFO - Rotation: Supported 13:55:47 INFO - Return code: 0 13:55:47 INFO - Running post-action listener: _resource_record_post_action 13:55:47 INFO - [mozharness: 2016-08-26 20:55:47.843072Z] Finished run-tests step (success) 13:55:47 INFO - Running post-run listener: _resource_record_post_run 13:55:47 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1155072; Write bytes: 707067904; Read time: 14; Write time: 1939 13:55:47 INFO - TinderboxPrint: CPU usage
54.4% 13:55:47 INFO - TinderboxPrint: I/O read bytes / time
1,155,072 / 14 13:55:47 INFO - TinderboxPrint: I/O write bytes / time
707,067,904 / 1,939 13:55:47 INFO - TinderboxPrint: CPU idle
2,207.5 (45.6%) 13:55:47 INFO - TinderboxPrint: CPU system
980.3 (20.2%) 13:55:47 INFO - TinderboxPrint: CPU user
1,653.9 (34.2%) 13:55:47 INFO - TinderboxPrint: Swap in / out
407,470,080 / 0 13:55:47 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406704640; Write bytes: 409875968; Read time: 29889; Write time: 810 13:55:47 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1044480; Write bytes: 295954944; Read time: 12; Write time: 1123 13:55:48 INFO - Running post-run listener: _upload_blobber_files 13:55:48 INFO - Blob upload gear active. 13:55:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:55:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:55:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:55:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:55:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:55:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:49 INFO - (blobuploader) - INFO - Done attempting. 13:55:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:55:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:50 INFO - (blobuploader) - INFO - Done attempting. 13:55:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:55:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:55:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:53 INFO - (blobuploader) - INFO - Done attempting. 13:55:53 INFO - (blobuploader) - INFO - Iteration through files over. 13:55:53 INFO - Return code: 0 13:55:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:55:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:55:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a45924052d047b9ea9bfc1e26dc8f36041daf869ed2c6a9a3f430a0f1381bbf1669ddb539ccc3be13a72e76ef4ad18cc85732a098b388c71821b5d83f7b8fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea74e594940f0f18f4ab0d8d3873ecca491781d16f44f42e802a39b8e750f0d15feeb13d757b66be60930d71237c54b38eb4f999aa46295a0299ea6961309bfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab422f07d70c44244978e5d86829d0f0798a8386cc64af6aac1dc87972925d96ecc34a6ed72fa61d6194d6dd323f99662aadbf854fe8b023714f2cc389e7d44f"} 13:55:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:55:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:55:53 INFO - Contents: 13:55:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a45924052d047b9ea9bfc1e26dc8f36041daf869ed2c6a9a3f430a0f1381bbf1669ddb539ccc3be13a72e76ef4ad18cc85732a098b388c71821b5d83f7b8fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea74e594940f0f18f4ab0d8d3873ecca491781d16f44f42e802a39b8e750f0d15feeb13d757b66be60930d71237c54b38eb4f999aa46295a0299ea6961309bfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab422f07d70c44244978e5d86829d0f0798a8386cc64af6aac1dc87972925d96ecc34a6ed72fa61d6194d6dd323f99662aadbf854fe8b023714f2cc389e7d44f"} 13:55:53 INFO - Running post-run listener: copy_logs_to_upload_dir 13:55:53 INFO - Copying logs to upload dir... 13:55:53 INFO - mkdir: /builds/slave/test/build/upload/logs 13:55:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.900485 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-26 13:55:53.413171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 13:55:53.416524) ========= 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.z8m4pX9903/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.e70tv1JM9H/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:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a45924052d047b9ea9bfc1e26dc8f36041daf869ed2c6a9a3f430a0f1381bbf1669ddb539ccc3be13a72e76ef4ad18cc85732a098b388c71821b5d83f7b8fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea74e594940f0f18f4ab0d8d3873ecca491781d16f44f42e802a39b8e750f0d15feeb13d757b66be60930d71237c54b38eb4f999aa46295a0299ea6961309bfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab422f07d70c44244978e5d86829d0f0798a8386cc64af6aac1dc87972925d96ecc34a6ed72fa61d6194d6dd323f99662aadbf854fe8b023714f2cc389e7d44f"} build_url:https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/Jdrx4_dvRdCAba7URD1Dkw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a45924052d047b9ea9bfc1e26dc8f36041daf869ed2c6a9a3f430a0f1381bbf1669ddb539ccc3be13a72e76ef4ad18cc85732a098b388c71821b5d83f7b8fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea74e594940f0f18f4ab0d8d3873ecca491781d16f44f42e802a39b8e750f0d15feeb13d757b66be60930d71237c54b38eb4f999aa46295a0299ea6961309bfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab422f07d70c44244978e5d86829d0f0798a8386cc64af6aac1dc87972925d96ecc34a6ed72fa61d6194d6dd323f99662aadbf854fe8b023714f2cc389e7d44f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 13:55:53.455093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:55:53.455498) ========= 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.z8m4pX9903/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.e70tv1JM9H/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.005214 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:55:53.506205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 13:55:53.506579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 13:55:53.507041) ========= ========= Total master_lag: 0.20 =========