builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0069 starttime: 1472514705.11 results: success (0) buildid: 20160829133031 builduid: 5cf13757889f43dd95c46aa607b25e69 revision: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.115092) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.115698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.116075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.203539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.203933) ========= 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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-29 16:51:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.9M=0.001s 2016-08-29 16:51:45 (15.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.381644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.381960) ========= 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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.028715 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.431116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:45.431513) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 --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 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-29 16:51:45,509 truncating revision to first 12 chars 2016-08-29 16:51:45,509 Setting DEBUG logging. 2016-08-29 16:51:45,509 attempt 1/10 2016-08-29 16:51:45,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/578a16bf30e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 16:51:46,100 unpacking tar archive at: fx-team-578a16bf30e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.845224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:46.298913) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:46.299230) ========= script_repo_revision: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:46.299638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:46.299903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 16:51:46.318565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-29 16:51:46.318851) ========= /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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:51:46 INFO - MultiFileLogger online at 20160829 16:51:46 in /builds/slave/test 16:51:46 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 16:51:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:51:46 INFO - {'append_to_log': False, 16:51:46 INFO - 'base_work_dir': '/builds/slave/test', 16:51:46 INFO - 'blob_upload_branch': 'Fx-Team', 16:51:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:51:46 INFO - 'branch': 'Fx-Team', 16:51:46 INFO - 'buildbot_json_path': 'buildprops.json', 16:51:46 INFO - 'config_files': ('talos/mac_config.py',), 16:51:46 INFO - 'default_actions': ('clobber', 16:51:46 INFO - 'read-buildbot-config', 16:51:46 INFO - 'download-and-extract', 16:51:46 INFO - 'populate-webroot', 16:51:46 INFO - 'create-virtualenv', 16:51:46 INFO - 'install', 16:51:46 INFO - 'run-tests'), 16:51:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:51:46 INFO - 'download_minidump_stackwalk': True, 16:51:46 INFO - 'download_symbols': 'ondemand', 16:51:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:51:46 INFO - 'tooltool.py': '/tools/tooltool.py', 16:51:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:51:46 INFO - '/tools/misc-python/virtualenv.py')}, 16:51:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:51:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:51:46 INFO - 'installer_path': 'installer.exe', 16:51:46 INFO - 'log_level': 'info', 16:51:46 INFO - 'log_name': 'talos', 16:51:46 INFO - 'log_to_console': True, 16:51:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:51:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:51:46 INFO - 'opt_config_files': (), 16:51:46 INFO - 'pip_index': False, 16:51:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:51:46 INFO - 'cmd': ('bash', 16:51:46 INFO - '-c', 16:51:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:51:46 INFO - 'enabled': True, 16:51:46 INFO - 'halt_on_failure': False, 16:51:46 INFO - 'name': 'check_screen_resolution'},), 16:51:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:51:46 INFO - 'cmd': ('bash', 16:51:46 INFO - '-c', 16:51:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:51:46 INFO - 'enabled': True, 16:51:46 INFO - 'halt_on_failure': False, 16:51:46 INFO - 'name': 'check_screen_resolution'},), 16:51:46 INFO - 'run_cmd_checks_enabled': True, 16:51:46 INFO - 'sps_profile': False, 16:51:46 INFO - 'sps_profile_interval': 0, 16:51:46 INFO - 'suite': 'dromaeojs-e10s', 16:51:46 INFO - 'system_bits': '32', 16:51:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:51:46 INFO - 'title': 't-yosemite-r7-0069', 16:51:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:51:46 INFO - 'use_talos_json': True, 16:51:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:51:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:51:46 INFO - 'work_dir': 'build'} 16:51:46 INFO - [mozharness: 2016-08-29 23:51:46.524799Z] Running clobber step. 16:51:46 INFO - Running pre-action listener: _resource_record_pre_action 16:51:46 INFO - Running main action method: clobber 16:51:46 INFO - rmtree: /builds/slave/test/build 16:51:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:51:48 INFO - Running post-action listener: _resource_record_post_action 16:51:48 INFO - [mozharness: 2016-08-29 23:51:48.602575Z] Finished clobber step (success) 16:51:48 INFO - [mozharness: 2016-08-29 23:51:48.602762Z] Running read-buildbot-config step. 16:51:48 INFO - Running pre-action listener: _resource_record_pre_action 16:51:48 INFO - Running main action method: read_buildbot_config 16:51:48 INFO - Using buildbot properties: 16:51:48 INFO - { 16:51:48 INFO - "project": "", 16:51:48 INFO - "product": "firefox", 16:51:48 INFO - "script_repo_revision": "production", 16:51:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:51:48 INFO - "repository": "", 16:51:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:51:48 INFO - "buildid": "20160829133031", 16:51:48 INFO - "pgo_build": "False", 16:51:48 INFO - "basedir": "/builds/slave/test", 16:51:48 INFO - "buildnumber": 80, 16:51:48 INFO - "slavename": "t-yosemite-r7-0069", 16:51:48 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:51:48 INFO - "platform": "yosemite_r7", 16:51:48 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:51:48 INFO - "branch": "fx-team", 16:51:48 INFO - "repo_path": "integration/fx-team", 16:51:48 INFO - "revision": "578a16bf30e47ceb2aba7c5fd53b7eaba9829610", 16:51:48 INFO - "stage_platform": "macosx64", 16:51:48 INFO - "builduid": "5cf13757889f43dd95c46aa607b25e69", 16:51:48 INFO - "slavebuilddir": "test" 16:51:48 INFO - } 16:51:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:51:48 INFO - Running post-action listener: _resource_record_post_action 16:51:48 INFO - [mozharness: 2016-08-29 23:51:48.607288Z] Finished read-buildbot-config step (success) 16:51:48 INFO - [mozharness: 2016-08-29 23:51:48.607456Z] Running download-and-extract step. 16:51:48 INFO - Running pre-action listener: _resource_record_pre_action 16:51:48 INFO - Running main action method: download_and_extract 16:51:48 INFO - mkdir: /builds/slave/test/build/tests 16:51:48 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')]} 16:51:48 INFO - trying https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:51:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:51:49 INFO - Downloaded 1199 bytes. 16:51:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:51:49 INFO - Using the following test package requirements: 16:51:49 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:51:49 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:51:49 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:51:49 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'jsshell-mac.zip'], 16:51:49 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:51:49 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:51:49 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:51:49 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:51:49 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:51:49 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:51:49 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:51:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:51:49 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')]} 16:51:49 INFO - trying https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:51:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:51:50 INFO - Downloaded 16370023 bytes. 16:51:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:51:57 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 16:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:57 INFO - trying https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:51:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:51:58 INFO - Downloaded 16370023 bytes. 16:51:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:52:05 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')]} 16:52:05 INFO - trying https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:52:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:52:06 INFO - Downloaded 14413998 bytes. 16:52:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 16:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:06 INFO - trying https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:52:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:52:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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 16:52:09 INFO - Downloaded 111525909 bytes. 16:52:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:52:09 INFO - mkdir: /builds/slave/test/properties 16:52:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:09 INFO - Contents: 16:52:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:52:10 INFO - Running post-action listener: _resource_record_post_action 16:52:10 INFO - Running post-action listener: set_extra_try_arguments 16:52:10 INFO - [mozharness: 2016-08-29 23:52:10.384101Z] Finished download-and-extract step (success) 16:52:10 INFO - [mozharness: 2016-08-29 23:52:10.384195Z] Running populate-webroot step. 16:52:10 INFO - Running pre-action listener: _resource_record_pre_action 16:52:10 INFO - Running main action method: populate_webroot 16:52:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:52:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:52:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:52:10 INFO - '--tppagecycles', 16:52:10 INFO - '7'], 16:52:10 INFO - 'tests': ['tsvgm']}}, 16:52:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:52:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:52:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:52:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:52:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['damp', 'tps']}, 16:52:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'tests': ['damp', 'tps']}, 16:52:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['dromaeo_dom']}, 16:52:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['basic_compositor_video']}, 16:52:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:52:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['a11yr', 16:52:10 INFO - 'ts_paint', 16:52:10 INFO - 'tpaint', 16:52:10 INFO - 'sessionrestore', 16:52:10 INFO - 'sessionrestore_no_auto_restore', 16:52:10 INFO - 'tabpaint']}, 16:52:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:52:10 INFO - 'ts_paint', 16:52:10 INFO - 'tpaint', 16:52:10 INFO - 'sessionrestore', 16:52:10 INFO - 'sessionrestore_no_auto_restore', 16:52:10 INFO - 'tabpaint']}, 16:52:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:52:10 INFO - 'ts_paint', 16:52:10 INFO - 'tpaint', 16:52:10 INFO - 'sessionrestore', 16:52:10 INFO - 'sessionrestore_no_auto_restore', 16:52:10 INFO - 'tabpaint']}, 16:52:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:52:10 INFO - 'ts_paint', 16:52:10 INFO - 'tpaint', 16:52:10 INFO - 'sessionrestore', 16:52:10 INFO - 'sessionrestore_no_auto_restore', 16:52:10 INFO - 'tabpaint']}, 16:52:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['a11yr', 16:52:10 INFO - 'ts_paint', 16:52:10 INFO - 'tpaint', 16:52:10 INFO - 'sessionrestore', 16:52:10 INFO - 'sessionrestore_no_auto_restore', 16:52:10 INFO - 'tabpaint']}, 16:52:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['a11yr', 16:52:10 INFO - 'ts_paint', 16:52:10 INFO - 'tpaint', 16:52:10 INFO - 'sessionrestore', 16:52:10 INFO - 'sessionrestore_no_auto_restore', 16:52:10 INFO - 'tabpaint']}, 16:52:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['tsvgx', 16:52:10 INFO - 'tsvgr_opacity', 16:52:10 INFO - 'tart', 16:52:10 INFO - 'tscrollx', 16:52:10 INFO - 'cart']}, 16:52:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:52:10 INFO - 'tsvgr_opacity', 16:52:10 INFO - 'tart', 16:52:10 INFO - 'tscrollx', 16:52:10 INFO - 'cart']}, 16:52:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'talos_options': ['--disable-e10s'], 16:52:10 INFO - 'tests': ['tp5o']}, 16:52:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'tests': ['tp5o']}, 16:52:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'talos_options': ['--disable-e10s', 16:52:10 INFO - '--xperf_path', 16:52:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:10 INFO - 'tests': ['tp5n']}, 16:52:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:10 INFO - 'talos_options': ['--xperf_path', 16:52:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:10 INFO - 'tests': ['tp5n']}}, 16:52:10 INFO - 'talos.zip': {'path': '', 16:52:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:52:10 INFO - Running post-action listener: _resource_record_post_action 16:52:10 INFO - [mozharness: 2016-08-29 23:52:10.403281Z] Finished populate-webroot step (success) 16:52:10 INFO - [mozharness: 2016-08-29 23:52:10.403412Z] Running create-virtualenv step. 16:52:10 INFO - Running pre-action listener: _resource_record_pre_action 16:52:10 INFO - Running main action method: create_virtualenv 16:52:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:10 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 16:52:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:52:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:10 INFO - Using real prefix '/tools/python27' 16:52:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:14 INFO - Installing pip.................done. 16:52:14 INFO - Return code: 0 16:52:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52: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', 'pip>=1.5'] in /builds/slave/test/build 16:52: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 pip>=1.5 16:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:14 INFO - 'HOME': '/Users/cltbld', 16:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:14 INFO - 'LOGNAME': 'cltbld', 16:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:14 INFO - 'MOZ_NO_REMOTE': '1', 16:52:14 INFO - 'NO_EM_RESTART': '1', 16:52:14 INFO - 'PAGER': '/bin/cat', 16:52:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:14 INFO - 'PWD': '/builds/slave/test', 16:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:14 INFO - 'SHELL': '/bin/bash', 16:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:14 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:14 INFO - 'USER': 'cltbld', 16:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:14 INFO - 'XPC_FLAGS': '0x0', 16:52:14 INFO - 'XPC_SERVICE_NAME': '0', 16:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:14 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 16:52:14 INFO - Cleaning up... 16:52:14 INFO - Return code: 0 16:52:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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')]} 16:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52: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', '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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:52: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 psutil>=3.1.1 16:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:14 INFO - 'HOME': '/Users/cltbld', 16:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:14 INFO - 'LOGNAME': 'cltbld', 16:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:14 INFO - 'MOZ_NO_REMOTE': '1', 16:52:14 INFO - 'NO_EM_RESTART': '1', 16:52:14 INFO - 'PAGER': '/bin/cat', 16:52:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:14 INFO - 'PWD': '/builds/slave/test', 16:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:14 INFO - 'SHELL': '/bin/bash', 16:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:14 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:14 INFO - 'USER': 'cltbld', 16:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:14 INFO - 'XPC_FLAGS': '0x0', 16:52:14 INFO - 'XPC_SERVICE_NAME': '0', 16:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:14 INFO - Downloading/unpacking psutil>=3.1.1 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:17 INFO - Installing collected packages: psutil 16:52:17 INFO - Running setup.py install for psutil 16:52:18 INFO - building 'psutil._psutil_osx' extension 16:52:18 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 16:52:18 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 16:52:18 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 16:52:18 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 16:52:18 INFO - building 'psutil._psutil_posix' extension 16:52:18 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 16:52:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:52:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:52:18 INFO - ^ 16:52:19 INFO - 1 warning generated. 16:52:19 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 16:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:19 INFO - Successfully installed psutil 16:52:19 INFO - Cleaning up... 16:52:19 INFO - Return code: 0 16:52:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:19 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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:19 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 16:52:19 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 16:52:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:19 INFO - 'HOME': '/Users/cltbld', 16:52:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:19 INFO - 'LOGNAME': 'cltbld', 16:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:19 INFO - 'MOZ_NO_REMOTE': '1', 16:52:19 INFO - 'NO_EM_RESTART': '1', 16:52:19 INFO - 'PAGER': '/bin/cat', 16:52:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:19 INFO - 'PWD': '/builds/slave/test', 16:52:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:19 INFO - 'SHELL': '/bin/bash', 16:52:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:19 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:19 INFO - 'USER': 'cltbld', 16:52:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:19 INFO - 'XPC_FLAGS': '0x0', 16:52:19 INFO - 'XPC_SERVICE_NAME': '0', 16:52:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:52:22 INFO - Installing collected packages: mozsystemmonitor 16:52:22 INFO - Running setup.py install for mozsystemmonitor 16:52:22 INFO - Successfully installed mozsystemmonitor 16:52:22 INFO - Cleaning up... 16:52:22 INFO - Return code: 0 16:52:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:22 INFO - 'HOME': '/Users/cltbld', 16:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:22 INFO - 'LOGNAME': 'cltbld', 16:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:22 INFO - 'MOZ_NO_REMOTE': '1', 16:52:22 INFO - 'NO_EM_RESTART': '1', 16:52:22 INFO - 'PAGER': '/bin/cat', 16:52:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:22 INFO - 'PWD': '/builds/slave/test', 16:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:22 INFO - 'SHELL': '/bin/bash', 16:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:22 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:22 INFO - 'USER': 'cltbld', 16:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:22 INFO - 'XPC_FLAGS': '0x0', 16:52:22 INFO - 'XPC_SERVICE_NAME': '0', 16:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:22 INFO - Downloading/unpacking jsonschema==2.5.1 16:52:22 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 16:52:22 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 16:52:22 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 16:52:22 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 16:52:22 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 16:52:22 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 16:52:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:52:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:25 INFO - Downloading functools32-3.2.3-2.tar.gz 16:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:52:25 INFO - warning: no files found matching '*.txt' 16:52:25 INFO - no previously-included directories found matching 'build' 16:52:25 INFO - no previously-included directories found matching 'dist' 16:52:25 INFO - no previously-included directories found matching '.git*' 16:52:25 INFO - Installing collected packages: jsonschema, functools32 16:52:25 INFO - Running setup.py install for functools32 16:52:25 INFO - warning: no files found matching '*.txt' 16:52:25 INFO - no previously-included directories found matching 'build' 16:52:25 INFO - no previously-included directories found matching 'dist' 16:52:25 INFO - no previously-included directories found matching '.git*' 16:52:25 INFO - Successfully installed jsonschema functools32 16:52:25 INFO - Cleaning up... 16:52:25 INFO - Return code: 0 16:52:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:52:25 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')]} 16:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:25 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')]} 16:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:25 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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:25 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 16:52:25 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 16:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:25 INFO - 'HOME': '/Users/cltbld', 16:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:25 INFO - 'LOGNAME': 'cltbld', 16:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:25 INFO - 'MOZ_NO_REMOTE': '1', 16:52:25 INFO - 'NO_EM_RESTART': '1', 16:52:25 INFO - 'PAGER': '/bin/cat', 16:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:25 INFO - 'PWD': '/builds/slave/test', 16:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:25 INFO - 'SHELL': '/bin/bash', 16:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:25 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:25 INFO - 'USER': 'cltbld', 16:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:25 INFO - 'XPC_FLAGS': '0x0', 16:52:25 INFO - 'XPC_SERVICE_NAME': '0', 16:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:52:25 INFO - Cleaning up... 16:52:25 INFO - Return code: 0 16:52:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:52:25 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')]} 16:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:25 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')]} 16:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:25 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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:25 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 16:52:25 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 16:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:25 INFO - 'HOME': '/Users/cltbld', 16:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:25 INFO - 'LOGNAME': 'cltbld', 16:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:25 INFO - 'MOZ_NO_REMOTE': '1', 16:52:25 INFO - 'NO_EM_RESTART': '1', 16:52:25 INFO - 'PAGER': '/bin/cat', 16:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:25 INFO - 'PWD': '/builds/slave/test', 16:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:25 INFO - 'SHELL': '/bin/bash', 16:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:25 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:25 INFO - 'USER': 'cltbld', 16:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:25 INFO - 'XPC_FLAGS': '0x0', 16:52:25 INFO - 'XPC_SERVICE_NAME': '0', 16:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:26 INFO - Downloading/unpacking blobuploader==1.2.4 16:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:28 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:52:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:30 INFO - Downloading docopt-0.6.1.tar.gz 16:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:52:30 INFO - Installing collected packages: blobuploader, requests, docopt 16:52:30 INFO - Running setup.py install for blobuploader 16:52:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:52:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:52:30 INFO - Running setup.py install for requests 16:52:30 INFO - Running setup.py install for docopt 16:52:30 INFO - Successfully installed blobuploader requests docopt 16:52:30 INFO - Cleaning up... 16:52:31 INFO - Return code: 0 16:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:31 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')]} 16:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:31 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')]} 16:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:31 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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:31 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 16:52:31 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 16:52:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:31 INFO - 'HOME': '/Users/cltbld', 16:52:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:31 INFO - 'LOGNAME': 'cltbld', 16:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:31 INFO - 'MOZ_NO_REMOTE': '1', 16:52:31 INFO - 'NO_EM_RESTART': '1', 16:52:31 INFO - 'PAGER': '/bin/cat', 16:52:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:31 INFO - 'PWD': '/builds/slave/test', 16:52:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:31 INFO - 'SHELL': '/bin/bash', 16:52:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:31 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:31 INFO - 'USER': 'cltbld', 16:52:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:31 INFO - 'XPC_FLAGS': '0x0', 16:52:31 INFO - 'XPC_SERVICE_NAME': '0', 16:52:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:31 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-QYYhKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:31 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-NPWoa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:31 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-bVbo9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:31 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-yvQ5w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:31 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-_6JhO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:31 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-SvIHbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:31 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-DwXZ6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-eJ42Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-_zSjve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-FIQgIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-TMjbTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-VR3C92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-8VCkm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ksTq6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-K3qlAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:32 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-HgvO81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:33 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-K2pXnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:52:33 INFO - Running setup.py install for manifestparser 16:52:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:52:33 INFO - Running setup.py install for mozcrash 16:52:33 INFO - Running setup.py install for mozdebug 16:52:33 INFO - Running setup.py install for mozdevice 16:52:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:52:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:52:33 INFO - Running setup.py install for mozfile 16:52:33 INFO - Running setup.py install for mozhttpd 16:52:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Running setup.py install for mozinfo 16:52:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Running setup.py install for mozInstall 16:52:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Running setup.py install for mozleak 16:52:34 INFO - Running setup.py install for mozlog 16:52:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Running setup.py install for moznetwork 16:52:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:52:34 INFO - Running setup.py install for mozprocess 16:52:34 INFO - Running setup.py install for mozprofile 16:52:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:52:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:52:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:52:35 INFO - Running setup.py install for mozrunner 16:52:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:52:35 INFO - Running setup.py install for mozscreenshot 16:52:35 INFO - Running setup.py install for moztest 16:52:35 INFO - Running setup.py install for mozversion 16:52:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:52:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:52:35 INFO - Cleaning up... 16:52:35 INFO - Return code: 0 16:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:35 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')]} 16:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:35 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')]} 16:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:35 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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:35 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 16:52:35 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 16:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:35 INFO - 'HOME': '/Users/cltbld', 16:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:35 INFO - 'LOGNAME': 'cltbld', 16:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:35 INFO - 'MOZ_NO_REMOTE': '1', 16:52:35 INFO - 'NO_EM_RESTART': '1', 16:52:35 INFO - 'PAGER': '/bin/cat', 16:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:35 INFO - 'PWD': '/builds/slave/test', 16:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:35 INFO - 'SHELL': '/bin/bash', 16:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:35 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:35 INFO - 'USER': 'cltbld', 16:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:35 INFO - 'XPC_FLAGS': '0x0', 16:52:35 INFO - 'XPC_SERVICE_NAME': '0', 16:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-tirPjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-3LKODz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-11cXbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ruzQdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-EJJkA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-vEHeey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-9Tcce1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-OTYHi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Xl7ose-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:36 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)) 16:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:36 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-XYlKdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:37 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)) 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:37 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-SXiLRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:37 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)) 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:37 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-fIhxRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:37 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)) 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:37 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-uzXPhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:37 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)) 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:37 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-GImArf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:37 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)) 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:37 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-LqQ4N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:37 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)) 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:37 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-sPr8CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:37 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)) 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:37 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-EetIDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:37 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)) 16:52:37 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)) 16:52:37 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)) 16:52:37 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)) 16:52:37 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)) 16:52:37 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)) 16:52:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:52:37 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 16:52:37 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 16:52:37 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 16:52:37 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 16:52:37 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 16:52:37 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 16:52:40 INFO - Downloading blessings-1.6.tar.gz 16:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:52:40 INFO - Installing collected packages: blessings 16:52:40 INFO - Running setup.py install for blessings 16:52:40 INFO - Successfully installed blessings 16:52:40 INFO - Cleaning up... 16:52:40 INFO - Return code: 0 16:52:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:40 INFO - Reading from file tmpfile_stdout 16:52:40 INFO - Current package versions: 16:52:40 INFO - blessings == 1.6 16:52:40 INFO - blobuploader == 1.2.4 16:52:40 INFO - docopt == 0.6.1 16:52:40 INFO - functools32 == 3.2.3-2 16:52:40 INFO - jsonschema == 2.5.1 16:52:40 INFO - manifestparser == 1.1 16:52:40 INFO - mozInstall == 1.12 16:52:40 INFO - mozcrash == 0.17 16:52:40 INFO - mozdebug == 0.1 16:52:40 INFO - mozdevice == 0.48 16:52:40 INFO - mozfile == 1.2 16:52:40 INFO - mozhttpd == 0.7 16:52:40 INFO - mozinfo == 0.9 16:52:40 INFO - mozleak == 0.1 16:52:40 INFO - mozlog == 3.3 16:52:40 INFO - moznetwork == 0.27 16:52:40 INFO - mozprocess == 0.23 16:52:40 INFO - mozprofile == 0.28 16:52:40 INFO - mozrunner == 6.12 16:52:40 INFO - mozscreenshot == 0.1 16:52:40 INFO - mozsystemmonitor == 0.3 16:52:40 INFO - moztest == 0.7 16:52:40 INFO - mozversion == 1.4 16:52:40 INFO - psutil == 3.1.1 16:52:40 INFO - requests == 1.2.3 16:52:40 INFO - wsgiref == 0.1.2 16:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:40 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')]} 16:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:41 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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:41 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 16:52:41 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 16:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:41 INFO - 'HOME': '/Users/cltbld', 16:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:41 INFO - 'LOGNAME': 'cltbld', 16:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:41 INFO - 'MOZ_NO_REMOTE': '1', 16:52:41 INFO - 'NO_EM_RESTART': '1', 16:52:41 INFO - 'PAGER': '/bin/cat', 16:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:41 INFO - 'PWD': '/builds/slave/test', 16:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:41 INFO - 'SHELL': '/bin/bash', 16:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:41 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:41 INFO - 'USER': 'cltbld', 16:52:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:41 INFO - 'XPC_FLAGS': '0x0', 16:52:41 INFO - 'XPC_SERVICE_NAME': '0', 16:52:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 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)) 16:52:41 INFO - Cleaning up... 16:52:41 INFO - Return code: 0 16:52:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:41 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 0x105444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b47b500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, '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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 16:52:41 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 16:52:41 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 16:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:52:41 INFO - 'HOME': '/Users/cltbld', 16:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:52:41 INFO - 'LOGNAME': 'cltbld', 16:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:41 INFO - 'MOZ_NO_REMOTE': '1', 16:52:41 INFO - 'NO_EM_RESTART': '1', 16:52:41 INFO - 'PAGER': '/bin/cat', 16:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:41 INFO - 'PWD': '/builds/slave/test', 16:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:52:41 INFO - 'SHELL': '/bin/bash', 16:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:52:41 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:52:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:52:41 INFO - 'USER': 'cltbld', 16:52:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:52:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:41 INFO - 'XPC_FLAGS': '0x0', 16:52:41 INFO - 'XPC_SERVICE_NAME': '0', 16:52:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:52:41 INFO - Cleaning up... 16:52:41 INFO - Return code: 0 16:52:41 INFO - Running post-action listener: _resource_record_post_action 16:52:41 INFO - Running post-action listener: _start_resource_monitoring 16:52:41 INFO - Starting resource monitoring. 16:52:41 INFO - [mozharness: 2016-08-29 23:52:41.814832Z] Finished create-virtualenv step (success) 16:52:41 INFO - [mozharness: 2016-08-29 23:52:41.815843Z] Running install step. 16:52:41 INFO - Running pre-action listener: _resource_record_pre_action 16:52:41 INFO - Running main action method: install 16:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:42 INFO - Reading from file tmpfile_stdout 16:52:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:52:42 INFO - Reading from file tmpfile_stdout 16:52:42 INFO - Output received: 16:52:42 INFO - Usage: mozinstall [options] installer 16:52:42 INFO - Options: 16:52:42 INFO - -h, --help show this help message and exit 16:52:42 INFO - -d DEST, --destination=DEST 16:52:42 INFO - Directory to install application into. [default: 16:52:42 INFO - "/builds/slave/test"] 16:52:42 INFO - --app=APP Application being installed. [default: firefox] 16:52:42 INFO - mkdir: /builds/slave/test/build/application 16:52:42 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'] 16:52:42 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 16:53:16 INFO - Reading from file tmpfile_stdout 16:53:16 INFO - Output received: 16:53:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:53:16 INFO - Running post-action listener: _resource_record_post_action 16:53:16 INFO - [mozharness: 2016-08-29 23:53:16.636086Z] Finished install step (success) 16:53:16 INFO - [mozharness: 2016-08-29 23:53:16.636232Z] Running run-tests step. 16:53:16 INFO - Running pre-action listener: _resource_record_pre_action 16:53:16 INFO - Running main action method: run_tests 16:53:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:53:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:53:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:53:16 INFO - 2016-08-29 16:53:16.650 screenresolution[1636:7829] starting screenresolution argv=screenresolution get 16:53:16 INFO - 2016-08-29 16:53:16.653 screenresolution[1636:7829] Display 0: 1600x1200x32@60 16:53:16 INFO - 2016-08-29 16:53:16.659 screenresolution[1637:7832] starting screenresolution argv=screenresolution list 16:53:16 INFO - Available Modes on Display 0 16:53:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:53:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:53:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:53:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:53:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:53:16 INFO - Intel Iris: 16:53:16 INFO - Chipset Model: Intel Iris 16:53:16 INFO - Type: GPU 16:53:16 INFO - Bus: Built-In 16:53:16 INFO - VRAM (Dynamic, Max): 1536 MB 16:53:16 INFO - Vendor: Intel (0x8086) 16:53:16 INFO - Device ID: 0x0a2e 16:53:16 INFO - Revision ID: 0x0009 16:53:16 INFO - Displays: 16:53:16 INFO - Display: 16:53:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:53:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:53:16 INFO - Display Serial Number: 1600x1200 60 16:53:16 INFO - Main Display: Yes 16:53:16 INFO - Mirror: Off 16:53:16 INFO - Online: Yes 16:53:16 INFO - Rotation: Supported 16:53:16 INFO - Return code: 0 16:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:16 INFO - Python 2.7.3 16:53:16 INFO - Return code: 0 16:53:16 INFO - grabbing minidump binary from tooltool 16:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:16 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 0x1053a8d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053a0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:16 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 16:53:16 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 16:53:16 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 16:53:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:17 INFO - Return code: 0 16:53:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:53:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:53:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:17 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/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--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 16:53:17 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/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0069 --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 16:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZvwDmpzGI/Render', 16:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:17 INFO - 'HOME': '/Users/cltbld', 16:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:17 INFO - 'LOGNAME': 'cltbld', 16:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:17 INFO - 'MOZ_NO_REMOTE': '1', 16:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:17 INFO - 'NO_EM_RESTART': '1', 16:53:17 INFO - 'PAGER': '/bin/cat', 16:53:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:17 INFO - 'PWD': '/builds/slave/test', 16:53:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:17 INFO - 'SHELL': '/bin/bash', 16:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pJ8k6V2DUS/Listeners', 16:53:17 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 16:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:17 INFO - 'USER': 'cltbld', 16:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:17 INFO - 'XPC_FLAGS': '0x0', 16:53:17 INFO - 'XPC_SERVICE_NAME': '0', 16:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:17 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/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--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 16:53:17 INFO - mozversion application_buildid: 20160829133031 16:53:17 INFO - mozversion application_changeset: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 16:53:17 INFO - mozversion application_display_name: Nightly 16:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:17 INFO - mozversion application_name: Firefox 16:53:17 INFO - mozversion application_remotingname: firefox 16:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:53:17 INFO - mozversion application_vendor: Mozilla 16:53:17 INFO - mozversion application_version: 51.0a1 16:53:17 INFO - mozversion platform_buildid: 20160829133031 16:53:17 INFO - mozversion platform_changeset: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 16:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:53:17 INFO - mozversion platform_version: 51.0a1 16:53:17 INFO - using testdate: 1472514797 16:53:17 INFO - actual date: 1472514797 16:53:17 INFO - starting webserver on 'localhost:49274' 16:53:17 INFO - SUITE-START | Running 2 tests 16:53:17 INFO - TEST-START | dromaeo_css 16:53:17 INFO - operating with platform_type : mac_ 16:53:17 INFO - Initialising browser for dromaeo_css test... 16:53:17 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpduGVfc/profile http://localhost:49274/getInfo.html) 16:53:20 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 16:53:20 INFO - PROCESS | 1647 | colorDepth:24 16:53:20 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 16:53:20 INFO - PROCESS | 1647 | __metrics 16:53:20 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:53:20 INFO - TEST-INFO | 1647: exit 0 16:53:20 INFO - Browser initialized. 16:53:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:20 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpduGVfc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:32 INFO - PROCESS | 1650 | RSS: Main: 244183040 16:53:32 INFO - PROCESS | 1650 | 16:54:22 INFO - PROCESS | 1650 | 1472514862547 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] 16:56:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 16:56:36 INFO - PROCESS | 1650 | RSS: Main: 262856704 16:56:36 INFO - PROCESS | 1650 | 16:59:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 16:59:39 INFO - PROCESS | 1650 | RSS: Main: 270864384 16:59:39 INFO - PROCESS | 1650 | 17:02:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 17:02:41 INFO - PROCESS | 1650 | RSS: Main: 275628032 17:02:41 INFO - PROCESS | 1650 | 17:05:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 17:05:43 INFO - PROCESS | 1650 | RSS: Main: 271839232 17:05:43 INFO - PROCESS | 1650 | 17:08:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 17:08:47 INFO - PROCESS | 1650 | RSS: Main: 277237760 17:08:47 INFO - PROCESS | 1650 | 17:11:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 17:11:50 INFO - PROCESS | 1650 | RSS: Main: 280100864 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | __start_tp_report 17:11:50 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 17:11:50 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 17:11:50 INFO - PROCESS | 1650 | |i|pagename|runs| 17:11:50 INFO - PROCESS | 1650 | |0;dojo.html;3419.640937701541;3454.84453199606;3455.688987991082;3459.1179249291426;3492.3189977954307;5872.060470324749;5878.706064696764;5917.585768996172;5955.731992060357;5962.165296858443;5606.21512988182;5790.971045144768;5834.387389324123;5859.736311865976;5909.2022576952095;5241.8427447176555;5356.4107948125675;5395.487428694268;5410.134378499441;5420.159875219348;4441.689081764278;5316.282301889234;5488.451154884519;5490.533304669088;5496.890062198773;5192.61055420845;5361.517463428271;5391.514763671269;5398.568114550826;5413.945860541384;5221.347331583552;5297.390800058004;5297.47025297471;5300.44345343741;5346.385165705916;5213.244079608474;5242.55438287746;5292.962209549312;5326.813561525328;5330.7334633268565;4866.878328041792;5782.248307720011;5820.417958204188;5926.288845338587;5947.286325640907;5673.886522269573;5881.941180588182;6264;6336.904946425807;6380.776672816429;6249.218847644044;6277.278113017016;6316.968415157895;6319.715612797435;6322.241331040259;5760;5881.382454842265;5884.911726324109;5970.820875373745;5985.371535988702;6376.744930202833;6377.936220637827;6378.84052898672;6384.106225128486;6421.678916054272;6247.00047992319;6253.937460625427;6266.655333956676;6273.811785646347;6273.8745225095245;5293.073712100444;6102.3983636914;6178.5366097542865;6315.210598675166;6346.01636746305;4762.857114286577;4893.804247830047;5534.446555344433;5630.324361076697;5946.137810017523;6184.783532576338;6274;6292.056191571301;6302.180716506825;6308.873822523524;4320.740755554677;4936.3829521309835;5041.395032596112;5042.193249080203;5076.847694569169;3702.6852717519314;4114.033202197481;4231.238377092153;4438.556144385536;4497.64018878489;5570.3315602128005;5942.851428714317;5950.791722289786;5955.821325360246;5961.165436838846;5221.425643179247;6191.4118158774845;6303.621782693053;6309.968450157719;6320.462760665395;5783.103618939072;5839.795607153729;5892.234009578728;5893.6463812171405;5978.133170690226;5485.286912701324;5500.339959204921;5501.119820828648;5509.3664228613425;5522.475364840334;6265.624062556261;6438.066480360415;6465.77369792055;6477.319881412383;6495.285518593046;6221.595596286227;6247.156633854372;6316.242050953915;6318.304986451579;6331.335209803088;6411.775587854403;6452.806415807533;6486.383793539606;6487.708053137526;6499.415052645285;6134.079888016655;6222.066689996536;6296.118543403835;6297.370262973666;6306.337834527309;6124.38756124384;6226.813195604139;6253;6263.029230469285;6291.496680265659;6162.661053641913;6238.064290356483;6244.406781355764;6250.562460627712;6251.9062214067735;6080.847978800565;6199.628022318675;6241.812745617457;6243.125962365181;6268.247810262797;5911.142884281841;6083.6045657032155;6133.457080270768;6137.938620613737;6155.938440615537;6170.290416602148;6202.2867370253;6209.192804935329;6242.28213755424;6270.498360131087;5956;6130.969345153246;6136.2636483622255;6143.662098584442;6144.139820425234 17:11:50 INFO - PROCESS | 1650 | |1;ext.html;515.1165750737485;537.5108651127472;539.7625044980208;548.5529293625697;593.4807043836643;39140.608593914054;41438.58561414385;41516.792416037875;41544.37683434744;41600.16799664005;42354;42603.78698106513;42898.14203715924;43001;43039.78480107603;9678.806423871536;9776.462294573796;9846.852297215511;9850.9656486069;9902.25733070019;9751.17115045222;9773.706788796311;9815.607375704963;9828.606855725799;9831.360961537514;9815.312928095036;9859.852102218472;9878.555465004056;9887.604495820158;9953.104220620178;9787.314887957846;9800.705978820612;9808.577756225342;9831.31180817343;9850.802983940353;9723;9796.951015244878;9804.607815687365;9821.607135714563;9828;40227.79316620506;40339.596604033875;40602.78191654255;40733.59266407328;40783.796081019405;3359.6136444308972;3360.0087974047715;3374.54443650109;3444.1389652586854;3744.588095309514;30768.076957691304;31251.687483125104;31798.841005794824;32058.839705801554;32174.51738223905;2927.6779554249015;3199.856006479714;3303.8348082596012;3305.983470082658;3317.0712200583876;495380;505451;505561;506080;509099.27205823443;59162;59751;59752;59800.401995980355;59812.700936495035;34818.9554313371;35312.47031294481;35912.92261232167;36486.45270320947;36565.08587285339;15880.761788573182;15917.204139792964;16023.519294421187;16077.758833617505;16078.598035049217;9737.977512361242;11942.104342174373;12237;12262.080343974238;12378.566750163882;15741.68516629661;19142;19332.613347732968;19369;19434.8056519433;6484.660399894058;7595.924040759522;7982.640781164861;7997.200279971957;8010.078840933251;727.8762610356252;939.8496240601607;996.4093357271182;1005.9647912323034;1060.5386656804314;28512.714872851422;29910;30113.548296775567;30944.156161365343;31013.8449307752;1006.5571148694551;1029.8815636201932;1052.1530168214508;1072.399456304472;1078.6494389323502;14414;14626.454561785347;15296.694066118615;15932.761008584881;15944.521664350088;678803;680365;680402;680622;680678;58208;58434.415655843746;58731;58784.7060764702;58831.94016717935;1297.9221246725226;1341.7115320206203;1349.7975303704523;1352.7294541091821;1361.101672895884;29209.85395073011;30224.84887575548;30435;30661.846690766404;30693.079207623807;43933;51661.48338516717;51664.48335516747;52014;52066.219006715684;595487;595981;598506;599496.0025199846;599941;26428.81070351877;26918.59622105631;27179.86410067937;27309.180724577498;27402.45195096047;38129.809350953066;47310.76344618255;47497;47886.28170577514;48049.279260810414;34380;36563.45154822733;38923.80538097292;39547;40633.59366406417;38514.614853851104;38923.2215355697;40557.797211013756;40573.594264056985;40846.38730418987;38656;38668.6133138665;39391.015224619616;39433.60566394414;39442.802785985885;26076;30230.395392091596;31736.523952141197;35191.824040879634;36744.81627591845;22319.553608928054;24004.39989000289;25311.240662780147;25756.61365079488;26086.478270434105 17:11:50 INFO - PROCESS | 1650 | |2;jquery.html;319.8512691598406;354.45591017787694;362.7714539839902;364.74467872489265;398.7906349166687;20097.196112155514;20996.475088122785;21185.94070296483;21669.566608667836;21916.780832191675;20882.06030728617;20996;21065;21249.787502124975;21320.4669883253;5353.411124776271;5924.289085309769;6071.119687645289;6124.326324104345;6201.410865967726;5338.492843179911;6142.600730952496;6144.877102457948;6150;6235;5839.79560715375;6018.127371531125;6019.578629495937;6020.969895150518;6032.758689652431;4797;5984.401559844003;6003.8198854034445;6047.788327408563;6049.818505444844;5954.612950158225;6076.5442591805795;6078.574499785017;6084.726187321581;6105.358937311607;13170.143940643924;16013.35946562136;20011.89934553599;25417.872910635513;26321.341966450993;2021.8382529397613;2538.99709614703;2578.716341202466;2755.1734479656025;2984.522476403765;9960.402375857399;9987.70036898887;10427.947860260727;12366.938165309115;15907.443239486678;1828.8628352873588;1840.1167439629053;1883.7897299535528;1889.9433017009512;1936.6417212815675;118749;123853.38073309665;125094.3745281277;128019;130122;10652.147828173727;10793.758717747403;10817.808746419825;11249.875012498685;11502.194846360842;14168.291585420688;14176.645583860485;14209.289535523183;14214.360353784105;14232.28838558068;8096.554689492016;8355.95822020886;8377.958110209533;8455.281301089353;8460.746177614681;8315.459495132796;8315.501069935823;8321.126281740451;8437.74686759386;8487.830243395221;4067.430559721641;4270.761479171006;4326.6754993375625;4385;4456.9331460028125;1669.6577201673629;1874.6531891600098;1915.186045930474;1933.7582802149732;1967.07547452697;813.5891374855778;898.2544488074882;904.900460949295;906.1301150895215;944.9763755906157;20180.59638807245;20635.58728825415;21487.785122148893;21489.35531934013;21501.67747483789;914.6432891172448;932.9207017403596;936.5925822267335;962.3263715399248;964.262339310428;10498.580056797795;11315.490802913724;11347.886521134684;11347.978681918667;11391.373474458818;576206;582825;589853;593292;596227;117410;121538;128779;133730.32539349352;135584.6441535572;981.5975450065439;998.7652901568125;1015.7206768138673;1024.3546565663733;1026.8665073540542;15597.298121584328;17760.513528106334;18085.547861303046;19896.50258743543;20230;56800.763889235;56860.71569642291;57058.42941570531;57810.71094644668;58066.709666451396;83927;84642.57678711567;84901;85237;85942;4912.975435122945;7236.276372362932;7361.779146625609;7563.886541701769;8094.676212951416;10665.680029599125;12490.438695163104;12498.125131240726;13076.607701768582;13245.80131298012;11077.667669969915;11155.832662509907;11310.717232069264;11310.773784524428;11518.884811151782;11213.271137376045;11270.492827822603;11423.029042531478;11574.800787850281;11728.70678233017;11019.393933333744;11285.605003824827;11618.012468939896;11715;11753;6667.733290668513;7270.636468176675;7354.227806080498;7421.332080112816;7487.737929172671;8660.870086948828;10258.846117308396;11169;11212.943935280271;11621.012213961907 17:11:50 INFO - PROCESS | 1650 | |3;mootools.html;1331.846837613674;1588.9126098064605;1657.6270339173686;1712.1610410898663;1860.4418674397677;7557.697692092316;8059.314958228558;8716.738497845075;9156;9165.358424910251;7509.699612015513;8712;8914.77713057174;8923.687670931518;8929.062448442917;2323.500447403808;2328.8951997160084;2341.625339945609;2352.2237661571726;2353.1293421434093;2334.1947028275304;2348.495073559184;2365.9881700591473;2372.7627237276306;2375.275540960015;1948.4349538633778;2330.4290448840056;2336.170659415908;2341.531693661266;2345.9560495579476;2309.6766452696634;2309.976900230993;2313.3406979010983;2319.814414846808;2319.860808351504;2312.9421764455856;2313.8727369994645;2321.4312493439047;2322.5703244899746;2330.196082351603;8936.106389361077;8940.329475289314;8973.641054357819;9012.729618111467;9018.36871419001;5257.842264732064;5347.304850369427;5397.433269506684;5401.567874570025;5427.592930530226;3316.2372654289406;3358.983205083959;3585.265020670782;3680.3375392429352;3684.8157592120288;1069.0752499088233;1100.1748688483638;1109.6393672056613;1123.9213255072148;1128.6230798425906;11640.301581905112;11685.70785730355;11793.882061179364;11810.523684539432;11811.287363332269;4398.912021759547;4553.840615578505;4727.267273572602;4813.278008298713;4843.2735089736825;9499.810003799885;9859.901400986042;9967.152792012761;9986.950065249772;9991.850122248172;5356.982173387044;5364.30264065669;5364.8122315718765;5366.114591092504;5367.892642147135;4198.454200953917;4398.076403955141;4744.264638980963;4855.028994201174;4884;3848.3457812171996;3937.547182074041;3998.640122388999;4017.979910100431;4042.1915616876154;1268.7525932443084;1271.3389037700344;1276.4830243751296;1277.8913792327755;1289.220021886745;850.8340873529726;906.3202598051462;942.236788201559;951.914466230289;956.9186619137452;4573.405457290531;5665.688387138664;6008.128821320884;6082.726277317532;6275.309715931244;376.38085349599754;424.8682908298437;429.9849505267363;431.8877091956051;450.27730492559624;3914.4715463412645;3999.6600288975765;4131.834726610962;4154.91690166201;4160.916781664349;9027.909720902839;9260.536973151451;10493.213009024354;10957.671269861918;11066.723331916766;9720.611175552898;9857.457839818735;10714.517846696917;10860.999999999842;10887.727806804734;8235.423520353517;8252.711155109662;8339.332853371716;8367.456115352483;8385.706500272583;5757.165211044459;5948.851278718067;5985.072313791369;6016.067509536029;6077.088436734525;9786.804263914824;9893.50532473359;9899.208063355058;10012.299139060196;10207.489625518843;9864.35881667718;10260.640877569249;10292.845607315747;10316.226283028653;10430.530626121994;7538.057742782153;7566.924330756622;7587.772366828784;7589.392848572212;7617.619119043915;8292.253697167283;8338.957630296212;8348.958255208685;8349.58252087381;8408.159184081544;7424.96287518559;7499.512531685423;7523.285287897641;7653.234676532302;7683.961580192064;6297.10166512761;7369.226231245856;7381.963090184515;7486.663100160615;7561.621918903923;6904;7063.540869843444;7065.0815393998455;7066.787996360117;7098.503104782616;4963.595317475633;5008.524190201925;5104.872378190575;5132.46109158533;5160.787215004546;5053.595712343077;5095.592352611708;5195.402528709247;5210.53105220532;5250.291210686509 17:11:50 INFO - PROCESS | 1650 | |4;prototype.html;257.79634089069634;269.96220529125924;285.1758418171484;301.35961082699265;308.0051433868604;4267.3598960156;4613.9538604613945;5017.397912250526;5332.893342133159;5535.695536745482;4307.655387568995;5157.3811142662835;5505.807296744615;5596.188552659862;5615.971920140393;3580.5166302549214;4267.698352002638;4278.122984788111;4306.590873866978;4341.979634785823;3918.960810391902;4214.620684138427;4294.849680261192;4314.288142456491;4346.913061738764;4097.836086556535;4103.835846566134;4137.482814648169;4164.729292595986;4201.43280657112;3323.5347051412823;4168;4182.53992060873;4191.098913733532;4227.372461602275;3006.6842981487066;3607.5851277103206;3615.222727113683;3617.113807117273;3631.8196586109357;5283.682979021271;5397.7031263280505;5411.458854114597;5425.969065877471;5495.368032676253;4009.919801603952;4137.841404406771;4226.562968590694;4389.9464128609225;4773.785179666923;5789.247397838296;5812.854678633025;5877.529797616223;5890.528757699374;5891;3493.6331685172945;4028.4158796974566;4074.5314288856866;4094.795260237006;4109.630133287988;6192.81421557354;6217.751289948396;6291.213598300213;6295.779647712354;6357.141785858896;4127.9174416511505;4139.985703502601;4152.979235103805;4155.335146376565;4158;3978.244133614604;4189.329707246887;4189.371594260885;4191.308434108338;4205.831766729297;4651.488336283006;4873.780679869415;4885.780139893643;4889.951100488949;4958.479359667183;5208.880090780501;5343.358796944314;5972.313183983897;6025.8192254232445;6063.363346848518;1109.7503061811028;1197.6107764976418;1424.508544552128;1434.8780353670054;1443.797868298439;937.4890684576922;943.6505796710769;960.4141473701037;967.4582233949011;990.1781521337273;4960.727160006234;5551.583631227674;5552.86117847049;5598.048331783607;5609.242752228479;4972.701637901738;5869.442402971711;6082.787102451482;6087.3303936566945;6226.59527130735;4471.032745591994;4649.69776964503;5504.256925315111;5580.302462192226;5619.690916999604;2581.4837032593555;2665.720099389575;2692.8922843086057;2761.613374127624;2782.220978126128;4708.529147085333;4904.558589726942;5139.864682543645;5374.656335916021;5418.566514678816;4838.854834354975;4998.450170481244;5183.5593974512585;5346.048692227309;5355.804869276795;4515.412996310459;4645.9303110453375;4670.649701272486;4984.850454486371;5454.61817672767;4323.610875021263;4458.748332092273;5120.001599688025;5173.92239116406;5246.213068039825;4246.405503229612;5122.74386280677;5918.526517878646;6104.572679912363;6226.0153501758;6218.751249949952;6219.284782249918;6420.903686444801;6499.967500162469;6541.672916354259;3535.027867336503;3958.327084395602;4019.3167161582014;4029.738067025634;4089.815958281944;5872.5301975842685;5899.852503687443;6237.28271248794;6252.718627661675;6269.373062693694;4976.5023497649945;5616.5787565931905;5982.132590774227;5985.9823829948145;6036.879262414815;4549.9307662698575;5183.896322073462;5518.420565840529;5947.821565353046;5950.375210602998;4768.499307572655;4991.725455100004;5427.453175844866;5871.970640146772;5927.140564618193;5456.399796022513;5541.251930989265;5972;5996.03196417776;6037.219020388908;4654.906901862011;4921.163402221702;5436.782528698966;5891.617044892068;5928.67392293428 17:11:50 INFO - PROCESS | 1650 | |5;yui.html;730.6310313291787;755.8034910923162;788.9921100788993;792.63142638673;839.7487743262539;14913.701725965488;15786.763198552031;15838.128902910335;15870.68258634828;15934.442294519695;14451.5664530064;14582.41670333188;14582.979191456603;14587.562373128796;14601.926990365033;808.3412019204344;821.7411515372669;850.3027517435705;857.1257317536109;857.5797859049084;830.8712149616789;860.8235311761106;861.543382007537;862.3360012790148;867.2628265973904;870.29071306885;886.2599729226104;912.543728135932;912.9954350228239;915.6520522201588;862.9352798540135;864.7146441674232;907.541691445819;907.8955920069177;908.0601577367426;652.3281020548842;653.2357142143655;668.0980676087291;669.6149713914518;669.8392385827415;14833.777493337608;15333.23333833315;15426.691466170725;15429.922850385788;15435.922820385938;13977.79033314501;14033.578992630237;14215.431382744679;14288.642783930381;14408;11800.232984856042;11845;11962.940185299105;12052.276863388224;12136.635900922987;3173.3018735878068;3764.3412402829667;3778.263238668433;3785.2051069275485;3919.862804801818;112492;113641.43179284134;113677.9057675384;113984.86015139826;116347.41826290815;10465.84301235482;10895.782084358269;10980.176486763525;11204.719882002852;11260.32438053703;17613.647727045645;18441.81558184401;21775.78224217769;21944.231951881608;23156.073757049868;6793.524453288322;7981.272102405807;8080.191980801873;8160.918390816016;8256.793580160544;4401.603855653007;4487.439070116236;4487.596116349544;4530.207213737583;4660.53394660538;3362.6637336266667;3551.058969373118;3578.3737845876867;3635.345637785224;3664.486971823947;623.7317953280042;697.4420463629076;707.6461769115442;726.3970904149543;743.0155044565972;572.4790440699027;637.4517914593446;648.8799572079087;661.8180000499901;666.8192720722128;7621.695132194761;7965.362770978308;9039.774005649911;9534.761630959143;9642.855357169648;594.8066878264582;609.9176611157437;640.385230179024;641.5060403489288;646.7865604350553;4629.606483448877;4649.767511624405;4724.833822384563;4775.2598347256235;4786.305985632064;97213;99582.50208749055;100230;128745.3562732199;134943;92294;106129;126567.99999999815;128333;130484.3475782615;107297.46351268193;109264.45367773269;109879;113273;116442.41778791221;9747.805043898941;9918.355306905029;9962.203023757937;9993.10062094415;9993.800123997335;63148.684256578425;63659;64489.35510644833;65229.67385163044;67835;66106;67731;76732.61633691796;80105;97869.53195702213;13282.269475178959;13468.98982576291;13729.725405492034;13839.100458470168;13982.65043373883;14760.778588321398;15072.37146539186;15318.157501337533;15492.380304787683;15663.37346506127;13830.654233643836;14039.973051875304;14075.396051730462;14107.788383174055;14663.413463461342;13961.232132232419;13983.370748316147;14028.509002184874;14069.577912662637;14896;13722.725545489235;14263.07290026145;14293.428262869369;14308;14346.139231646135;11149.163812713916;11316.773664526829;11338.433078345884;11478.540858365572;12003.1597788154;7417.730086997888;9337.019612940543;9743.707688769347;9795;10789.670100015177 17:11:50 INFO - PROCESS | 1650 | __end_tp_report 17:11:50 INFO - PROCESS | 1650 | __start_cc_report 17:11:50 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,380 17:11:50 INFO - PROCESS | 1650 | __end_cc_report 17:11:50 INFO - PROCESS | 1650 | __startTimestamp1472515910165__endTimestamp 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | ------- Summary: start ------- 17:11:50 INFO - PROCESS | 1650 | Number of tests: 6 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5785.42 Median:5962.17 stddev:678.32 (11.4%) stddev-sans-first:654.52 17:11:50 INFO - PROCESS | 1650 | Values: 3419.6 3454.8 3455.7 3459.1 3492.3 5872.1 5878.7 5917.6 5955.7 5962.2 5606.2 5791.0 5834.4 5859.7 5909.2 5241.8 5356.4 5395.5 5410.1 5420.2 4441.7 5316.3 5488.5 5490.5 5496.9 5192.6 5361.5 5391.5 5398.6 5413.9 5221.3 5297.4 5297.5 5300.4 5346.4 5213.2 5242.6 5293.0 5326.8 5330.7 4866.9 5782.2 5820.4 5926.3 5947.3 5673.9 5881.9 6264.0 6336.9 6380.8 6249.2 6277.3 6317.0 6319.7 6322.2 5760.0 5881.4 5884.9 5970.8 5985.4 6376.7 6377.9 6378.8 6384.1 6421.7 6247.0 6253.9 6266.7 6273.8 6273.9 5293.1 6102.4 6178.5 6315.2 6346.0 4762.9 4893.8 5534.4 5630.3 5946.1 6184.8 6274.0 6292.1 6302.2 6308.9 4320.7 4936.4 5041.4 5042.2 5076.8 3702.7 4114.0 4231.2 4438.6 4497.6 5570.3 5942.9 5950.8 5955.8 5961.2 5221.4 6191.4 6303.6 6310.0 6320.5 5783.1 5839.8 5892.2 5893.6 5978.1 5485.3 5500.3 5501.1 5509.4 5522.5 6265.6 6438.1 6465.8 6477.3 6495.3 6221.6 6247.2 6316.2 6318.3 6331.3 6411.8 6452.8 6486.4 6487.7 6499.4 6134.1 6222.1 6296.1 6297.4 6306.3 6124.4 6226.8 6253.0 6263.0 6291.5 6162.7 6238.1 6244.4 6250.6 6251.9 6080.8 6199.6 6241.8 6243.1 6268.2 5911.1 6083.6 6133.5 6137.9 6155.9 6170.3 6202.3 6209.2 6242.3 6270.5 5956.0 6131.0 6136.3 6143.7 6144.1 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:71621.48 Median:40448.70 stddev:160236.39 (396.1%) stddev-sans-first:160596.95 17:11:50 INFO - PROCESS | 1650 | Values: 515.1 537.5 539.8 548.6 593.5 39140.6 41438.6 41516.8 41544.4 41600.2 42354.0 42603.8 42898.1 43001.0 43039.8 9678.8 9776.5 9846.9 9851.0 9902.3 9751.2 9773.7 9815.6 9828.6 9831.4 9815.3 9859.9 9878.6 9887.6 9953.1 9787.3 9800.7 9808.6 9831.3 9850.8 9723.0 9797.0 9804.6 9821.6 9828.0 40227.8 40339.6 40602.8 40733.6 40783.8 3359.6 3360.0 3374.5 3444.1 3744.6 30768.1 31251.7 31798.8 32058.8 32174.5 2927.7 3199.9 3303.8 3306.0 3317.1 495380.0 505451.0 505561.0 506080.0 509099.3 59162.0 59751.0 59752.0 59800.4 59812.7 34819.0 35312.5 35912.9 36486.5 36565.1 15880.8 15917.2 16023.5 16077.8 16078.6 9738.0 11942.1 12237.0 12262.1 12378.6 15741.7 19142.0 19332.6 19369.0 19434.8 6484.7 7595.9 7982.6 7997.2 8010.1 727.9 939.8 996.4 1006.0 1060.5 28512.7 29910.0 30113.5 30944.2 31013.8 1006.6 1029.9 1052.2 1072.4 1078.6 14414.0 14626.5 15296.7 15932.8 15944.5 678803.0 680365.0 680402.0 680622.0 680678.0 58208.0 58434.4 58731.0 58784.7 58831.9 1297.9 1341.7 1349.8 1352.7 1361.1 29209.9 30224.8 30435.0 30661.8 30693.1 43933.0 51661.5 51664.5 52014.0 52066.2 595487.0 595981.0 598506.0 599496.0 599941.0 26428.8 26918.6 27179.9 27309.2 27402.5 38129.8 47310.8 47497.0 47886.3 48049.3 34380.0 36563.5 38923.8 39547.0 40633.6 38514.6 38923.2 40557.8 40573.6 40846.4 38656.0 38668.6 39391.0 39433.6 39442.8 26076.0 30230.4 31736.5 35191.8 36744.8 22319.6 24004.4 25311.2 25756.6 26086.5 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35117.21 Median:13998.29 stddev:98494.58 (703.6%) stddev-sans-first:98736.23 17:11:50 INFO - PROCESS | 1650 | Values: 319.9 354.5 362.8 364.7 398.8 20097.2 20996.5 21185.9 21669.6 21916.8 20882.1 20996.0 21065.0 21249.8 21320.5 5353.4 5924.3 6071.1 6124.3 6201.4 5338.5 6142.6 6144.9 6150.0 6235.0 5839.8 6018.1 6019.6 6021.0 6032.8 4797.0 5984.4 6003.8 6047.8 6049.8 5954.6 6076.5 6078.6 6084.7 6105.4 13170.1 16013.4 20011.9 25417.9 26321.3 2021.8 2539.0 2578.7 2755.2 2984.5 9960.4 9987.7 10427.9 12366.9 15907.4 1828.9 1840.1 1883.8 1889.9 1936.6 118749.0 123853.4 125094.4 128019.0 130122.0 10652.1 10793.8 10817.8 11249.9 11502.2 14168.3 14176.6 14209.3 14214.4 14232.3 8096.6 8356.0 8378.0 8455.3 8460.7 8315.5 8315.5 8321.1 8437.7 8487.8 4067.4 4270.8 4326.7 4385.0 4456.9 1669.7 1874.7 1915.2 1933.8 1967.1 813.6 898.3 904.9 906.1 945.0 20180.6 20635.6 21487.8 21489.4 21501.7 914.6 932.9 936.6 962.3 964.3 10498.6 11315.5 11347.9 11348.0 11391.4 576206.0 582825.0 589853.0 593292.0 596227.0 117410.0 121538.0 128779.0 133730.3 135584.6 981.6 998.8 1015.7 1024.4 1026.9 15597.3 17760.5 18085.5 19896.5 20230.0 56800.8 56860.7 57058.4 57810.7 58066.7 83927.0 84642.6 84901.0 85237.0 85942.0 4913.0 7236.3 7361.8 7563.9 8094.7 10665.7 12490.4 12498.1 13076.6 13245.8 11077.7 11155.8 11310.7 11310.8 11518.9 11213.3 11270.5 11423.0 11574.8 11728.7 11019.4 11285.6 11618.0 11715.0 11753.0 6667.7 7270.6 7354.2 7421.3 7487.7 8660.9 10258.8 11169.0 11212.9 11621.0 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5693.93 Median:5074.59 stddev:3206.31 (63.2%) stddev-sans-first:3198.54 17:11:50 INFO - PROCESS | 1650 | Values: 1331.8 1588.9 1657.6 1712.2 1860.4 7557.7 8059.3 8716.7 9156.0 9165.4 7509.7 8712.0 8914.8 8923.7 8929.1 2323.5 2328.9 2341.6 2352.2 2353.1 2334.2 2348.5 2366.0 2372.8 2375.3 1948.4 2330.4 2336.2 2341.5 2346.0 2309.7 2310.0 2313.3 2319.8 2319.9 2312.9 2313.9 2321.4 2322.6 2330.2 8936.1 8940.3 8973.6 9012.7 9018.4 5257.8 5347.3 5397.4 5401.6 5427.6 3316.2 3359.0 3585.3 3680.3 3684.8 1069.1 1100.2 1109.6 1123.9 1128.6 11640.3 11685.7 11793.9 11810.5 11811.3 4398.9 4553.8 4727.3 4813.3 4843.3 9499.8 9859.9 9967.2 9987.0 9991.9 5357.0 5364.3 5364.8 5366.1 5367.9 4198.5 4398.1 4744.3 4855.0 4884.0 3848.3 3937.5 3998.6 4018.0 4042.2 1268.8 1271.3 1276.5 1277.9 1289.2 850.8 906.3 942.2 951.9 956.9 4573.4 5665.7 6008.1 6082.7 6275.3 376.4 424.9 430.0 431.9 450.3 3914.5 3999.7 4131.8 4154.9 4160.9 9027.9 9260.5 10493.2 10957.7 11066.7 9720.6 9857.5 10714.5 10861.0 10887.7 8235.4 8252.7 8339.3 8367.5 8385.7 5757.2 5948.9 5985.1 6016.1 6077.1 9786.8 9893.5 9899.2 10012.3 10207.5 9864.4 10260.6 10292.8 10316.2 10430.5 7538.1 7566.9 7587.8 7589.4 7617.6 8292.3 8339.0 8349.0 8349.6 8408.2 7425.0 7499.5 7523.3 7653.2 7684.0 6297.1 7369.2 7382.0 7486.7 7561.6 6904.0 7063.5 7065.1 7066.8 7098.5 4963.6 5008.5 5104.9 5132.5 5160.8 5053.6 5095.6 5195.4 5210.5 5250.3 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4617.73 Median:4980.68 stddev:1440.91 (28.9%) stddev-sans-first:1407.30 17:11:50 INFO - PROCESS | 1650 | Values: 257.8 270.0 285.2 301.4 308.0 4267.4 4614.0 5017.4 5332.9 5535.7 4307.7 5157.4 5505.8 5596.2 5616.0 3580.5 4267.7 4278.1 4306.6 4342.0 3919.0 4214.6 4294.8 4314.3 4346.9 4097.8 4103.8 4137.5 4164.7 4201.4 3323.5 4168.0 4182.5 4191.1 4227.4 3006.7 3607.6 3615.2 3617.1 3631.8 5283.7 5397.7 5411.5 5426.0 5495.4 4009.9 4137.8 4226.6 4389.9 4773.8 5789.2 5812.9 5877.5 5890.5 5891.0 3493.6 4028.4 4074.5 4094.8 4109.6 6192.8 6217.8 6291.2 6295.8 6357.1 4127.9 4140.0 4153.0 4155.3 4158.0 3978.2 4189.3 4189.4 4191.3 4205.8 4651.5 4873.8 4885.8 4890.0 4958.5 5208.9 5343.4 5972.3 6025.8 6063.4 1109.8 1197.6 1424.5 1434.9 1443.8 937.5 943.7 960.4 967.5 990.2 4960.7 5551.6 5552.9 5598.0 5609.2 4972.7 5869.4 6082.8 6087.3 6226.6 4471.0 4649.7 5504.3 5580.3 5619.7 2581.5 2665.7 2692.9 2761.6 2782.2 4708.5 4904.6 5139.9 5374.7 5418.6 4838.9 4998.5 5183.6 5346.0 5355.8 4515.4 4645.9 4670.6 4984.9 5454.6 4323.6 4458.7 5120.0 5173.9 5246.2 4246.4 5122.7 5918.5 6104.6 6226.0 6218.8 6219.3 6420.9 6500.0 6541.7 3535.0 3958.3 4019.3 4029.7 4089.8 5872.5 5899.9 6237.3 6252.7 6269.4 4976.5 5616.6 5982.1 5986.0 6036.9 4549.9 5183.9 5518.4 5947.8 5950.4 4768.5 4991.7 5427.5 5872.0 5927.1 5456.4 5541.3 5972.0 5996.0 6037.2 4654.9 4921.2 5436.8 5891.6 5928.7 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:23393.72 Median:3781.73 stddev:35808.36 (946.9%) stddev-sans-first:35868.38 17:11:50 INFO - PROCESS | 1650 | Values: 730.6 755.8 789.0 792.6 839.7 14913.7 15786.8 15838.1 15870.7 15934.4 14451.6 14582.4 14583.0 14587.6 14601.9 808.3 821.7 850.3 857.1 857.6 830.9 860.8 861.5 862.3 867.3 870.3 886.3 912.5 913.0 915.7 862.9 864.7 907.5 907.9 908.1 652.3 653.2 668.1 669.6 669.8 14833.8 15333.2 15426.7 15429.9 15435.9 13977.8 14033.6 14215.4 14288.6 14408.0 11800.2 11845.0 11962.9 12052.3 12136.6 3173.3 3764.3 3778.3 3785.2 3919.9 112492.0 113641.4 113677.9 113984.9 116347.4 10465.8 10895.8 10980.2 11204.7 11260.3 17613.6 18441.8 21775.8 21944.2 23156.1 6793.5 7981.3 8080.2 8160.9 8256.8 4401.6 4487.4 4487.6 4530.2 4660.5 3362.7 3551.1 3578.4 3635.3 3664.5 623.7 697.4 707.6 726.4 743.0 572.5 637.5 648.9 661.8 666.8 7621.7 7965.4 9039.8 9534.8 9642.9 594.8 609.9 640.4 641.5 646.8 4629.6 4649.8 4724.8 4775.3 4786.3 97213.0 99582.5 100230.0 128745.4 134943.0 92294.0 106129.0 126568.0 128333.0 130484.3 107297.5 109264.5 109879.0 113273.0 116442.4 9747.8 9918.4 9962.2 9993.1 9993.8 63148.7 63659.0 64489.4 65229.7 67835.0 66106.0 67731.0 76732.6 80105.0 97869.5 13282.3 13469.0 13729.7 13839.1 13982.7 14760.8 15072.4 15318.2 15492.4 15663.4 13830.7 14040.0 14075.4 14107.8 14663.4 13961.2 13983.4 14028.5 14069.6 14896.0 13722.7 14263.1 14293.4 14308.0 14346.1 11149.2 11316.8 11338.4 11478.5 12003.2 7417.7 9337.0 9743.7 9795.0 10789.7 17:11:50 INFO - PROCESS | 1650 | -------- Summary: end -------- 17:11:50 INFO - PROCESS | 1650 | 17:11:50 INFO - TEST-INFO | 1650: exit 0 17:11:50 INFO - TEST-OK | dromaeo_css | took 1113646ms 17:11:50 INFO - TEST-START | kraken 17:11:50 INFO - operating with platform_type : mac_ 17:11:50 INFO - Initialising browser for kraken test... 17:11:50 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmp8gnrQI/profile http://localhost:49274/getInfo.html) 17:11:53 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 17:11:53 INFO - PROCESS | 1658 | colorDepth:24 17:11:53 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 17:11:53 INFO - PROCESS | 1658 | __metrics 17:11:53 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 17:11:54 INFO - TEST-INFO | 1658: exit 0 17:11:54 INFO - Browser initialized. 17:11:54 INFO - Running cycle 1/1 for kraken test... 17:11:54 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmp8gnrQI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:06 INFO - PROCESS | 1660 | RSS: Main: 244195328 17:12:06 INFO - PROCESS | 1660 | 17:12:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:09 INFO - PROCESS | 1660 | RSS: Main: 257138688 17:12:09 INFO - PROCESS | 1660 | 17:12:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 17:12:12 INFO - PROCESS | 1660 | RSS: Main: 265801728 17:12:12 INFO - PROCESS | 1660 | 17:12:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 17:12:17 INFO - PROCESS | 1660 | RSS: Main: 264192000 17:12:17 INFO - PROCESS | 1660 | 17:12:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 17:12:19 INFO - PROCESS | 1660 | RSS: Main: 266842112 17:12:19 INFO - PROCESS | 1660 | 17:12:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:22 INFO - PROCESS | 1660 | RSS: Main: 267239424 17:12:22 INFO - PROCESS | 1660 | 17:12:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:25 INFO - PROCESS | 1660 | RSS: Main: 267907072 17:12:25 INFO - PROCESS | 1660 | 17:12:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:29 INFO - PROCESS | 1660 | RSS: Main: 268357632 17:12:29 INFO - PROCESS | 1660 | 17:12:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 17:12:33 INFO - PROCESS | 1660 | RSS: Main: 268808192 17:12:33 INFO - PROCESS | 1660 | 17:12:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:35 INFO - PROCESS | 1660 | RSS: Main: 268181504 17:12:35 INFO - PROCESS | 1660 | 17:12:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:38 INFO - PROCESS | 1660 | RSS: Main: 267886592 17:12:38 INFO - PROCESS | 1660 | 17:12:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:41 INFO - PROCESS | 1660 | RSS: Main: 267984896 17:12:41 INFO - PROCESS | 1660 | 17:12:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:44 INFO - PROCESS | 1660 | RSS: Main: 267980800 17:12:44 INFO - PROCESS | 1660 | 17:12:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:12:48 INFO - PROCESS | 1660 | RSS: Main: 267808768 17:12:48 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 17:12:50 INFO - PROCESS | 1660 | RSS: Main: 269520896 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | __start_tp_report 17:12:50 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 17:12:50 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 17:12:50 INFO - PROCESS | 1660 | |i|pagename|runs| 17:12:50 INFO - PROCESS | 1660 | |0;ai-astar;116;112;116;116;118;101;116;116;118;116 17:12:50 INFO - PROCESS | 1660 | |1;audio-beat-detection;146;121;170;176;110;138;164;128;155;111 17:12:50 INFO - PROCESS | 1660 | |2;audio-dft;197;199;199;207;257;274;208;177;252;190 17:12:50 INFO - PROCESS | 1660 | |3;audio-fft;69;84;74;145;60;61;59;63;134;59 17:12:50 INFO - PROCESS | 1660 | |4;audio-oscillator;69;85;147;102;99;103;109;55;77;139 17:12:50 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;94;89;79;128;92;89;93;101;135;103 17:12:50 INFO - PROCESS | 1660 | |6;imaging-darkroom;101;101;129;124;102;101;115;110;142;128 17:12:50 INFO - PROCESS | 1660 | |7;imaging-desaturate;78;112;127;75;78;122;149;92;159;105 17:12:50 INFO - PROCESS | 1660 | |8;json-parse-financial;53;50;89;87;91;65;58;59;56;58 17:12:50 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;67;74;71;76;65;83;94;104;103;74 17:12:50 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;97;109;87;87;87;90;86;89;84;84 17:12:50 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;134;148;126;150;153;170;160;165;193;140 17:12:50 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;171;174;173;173;176;174;172;173;172;169 17:12:50 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;66;69;71;66;70;68;59;76;94;79 17:12:50 INFO - PROCESS | 1660 | __end_tp_report 17:12:50 INFO - PROCESS | 1660 | __start_cc_report 17:12:50 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,967 17:12:50 INFO - PROCESS | 1660 | __end_cc_report 17:12:50 INFO - PROCESS | 1660 | __startTimestamp1472515970439__endTimestamp 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | ------- Summary: start ------- 17:12:50 INFO - PROCESS | 1660 | Number of tests: 14 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.00 stddev:5.02 (4.3%) stddev-sans-first:5.29 17:12:50 INFO - PROCESS | 1660 | Values: 116.0 112.0 116.0 116.0 118.0 101.0 116.0 116.0 118.0 116.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:150.50 stddev:24.15 (16.0%) stddev-sans-first:25.56 17:12:50 INFO - PROCESS | 1660 | Values: 146.0 121.0 170.0 176.0 110.0 138.0 164.0 128.0 155.0 111.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:216.00 Median:207.50 stddev:32.70 (15.8%) stddev-sans-first:33.95 17:12:50 INFO - PROCESS | 1660 | Values: 197.0 199.0 199.0 207.0 257.0 274.0 208.0 177.0 252.0 190.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:80.80 Median:62.00 stddev:32.04 (51.7%) stddev-sans-first:33.70 17:12:50 INFO - PROCESS | 1660 | Values: 69.0 84.0 74.0 145.0 60.0 61.0 59.0 63.0 134.0 59.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:62.00 stddev:28.95 (46.7%) stddev-sans-first:28.67 17:12:50 INFO - PROCESS | 1660 | Values: 69.0 85.0 147.0 102.0 99.0 103.0 109.0 55.0 77.0 139.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:100.30 Median:89.00 stddev:17.80 (20.0%) stddev-sans-first:18.73 17:12:50 INFO - PROCESS | 1660 | Values: 94.0 89.0 79.0 128.0 92.0 89.0 93.0 101.0 135.0 103.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:115.30 Median:119.50 stddev:14.74 (12.3%) stddev-sans-first:14.70 17:12:50 INFO - PROCESS | 1660 | Values: 101.0 101.0 129.0 124.0 102.0 101.0 115.0 110.0 142.0 128.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:109.70 Median:117.00 stddev:29.78 (25.5%) stddev-sans-first:29.29 17:12:50 INFO - PROCESS | 1660 | Values: 78.0 112.0 127.0 75.0 78.0 122.0 149.0 92.0 159.0 105.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:62.00 stddev:15.97 (25.8%) stddev-sans-first:16.16 17:12:50 INFO - PROCESS | 1660 | Values: 53.0 50.0 89.0 87.0 91.0 65.0 58.0 59.0 56.0 58.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:81.10 Median:74.00 stddev:14.38 (19.4%) stddev-sans-first:14.32 17:12:50 INFO - PROCESS | 1660 | Values: 67.0 74.0 71.0 76.0 65.0 83.0 94.0 104.0 103.0 74.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:87.00 stddev:7.64 (8.8%) stddev-sans-first:7.68 17:12:50 INFO - PROCESS | 1660 | Values: 97.0 109.0 87.0 87.0 87.0 90.0 86.0 89.0 84.0 84.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:156.50 stddev:19.34 (12.4%) stddev-sans-first:19.13 17:12:50 INFO - PROCESS | 1660 | Values: 134.0 148.0 126.0 150.0 153.0 170.0 160.0 165.0 193.0 140.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:1.89 (1.1%) stddev-sans-first:1.90 17:12:50 INFO - PROCESS | 1660 | Values: 171.0 174.0 173.0 173.0 176.0 174.0 172.0 173.0 172.0 169.0 17:12:50 INFO - PROCESS | 1660 | 17:12:50 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:70.50 stddev:9.54 (13.5%) stddev-sans-first:9.89 17:12:50 INFO - PROCESS | 1660 | Values: 66.0 69.0 71.0 66.0 70.0 68.0 59.0 76.0 94.0 79.0 17:12:50 INFO - PROCESS | 1660 | -------- Summary: end -------- 17:12:50 INFO - PROCESS | 1660 | 17:12:51 INFO - TEST-INFO | 1660: exit 0 17:12:51 INFO - TEST-OK | kraken | took 60366ms 17:12:51 INFO - SUITE-END | took 1174s 17:12:51 INFO - Completed test suite (00:19:34) 17:12:51 INFO - javascript benchmark 17:12:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7350.846053110737, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.640937701541, 3454.84453199606, 3455.688987991082, 3459.1179249291426, 3492.3189977954307, 5872.060470324749, 5878.706064696764, 5917.585768996172, 5955.731992060357, 5962.165296858443, 5606.21512988182, 5790.971045144768, 5834.387389324123, 5859.736311865976, 5909.2022576952095, 5241.8427447176555, 5356.4107948125675, 5395.487428694268, 5410.134378499441, 5420.159875219348, 4441.689081764278, 5316.282301889234, 5488.451154884519, 5490.533304669088, 5496.890062198773, 5192.61055420845, 5361.517463428271, 5391.514763671269, 5398.568114550826, 5413.945860541384, 5221.347331583552, 5297.390800058004, 5297.47025297471, 5300.44345343741, 5346.385165705916, 5213.244079608474, 5242.55438287746, 5292.962209549312, 5326.813561525328, 5330.7334633268565, 4866.878328041792, 5782.248307720011, 5820.417958204188, 5926.288845338587, 5947.286325640907, 5673.886522269573, 5881.941180588182, 6264.0, 6336.904946425807, 6380.776672816429, 6249.218847644044, 6277.278113017016, 6316.968415157895, 6319.715612797435, 6322.241331040259, 5760.0, 5881.382454842265, 5884.911726324109, 5970.820875373745, 5985.371535988702, 6376.744930202833, 6377.936220637827, 6378.84052898672, 6384.106225128486, 6421.678916054272, 6247.00047992319, 6253.937460625427, 6266.655333956676, 6273.811785646347, 6273.8745225095245, 5293.073712100444, 6102.3983636914, 6178.5366097542865, 6315.210598675166, 6346.01636746305, 4762.857114286577, 4893.804247830047, 5534.446555344433, 5630.324361076697, 5946.137810017523, 6184.783532576338, 6274.0, 6292.056191571301, 6302.180716506825, 6308.873822523524, 4320.740755554677, 4936.3829521309835, 5041.395032596112, 5042.193249080203, 5076.847694569169, 3702.6852717519314, 4114.033202197481, 4231.238377092153, 4438.556144385536, 4497.64018878489, 5570.3315602128005, 5942.851428714317, 5950.791722289786, 5955.821325360246, 5961.165436838846, 5221.425643179247, 6191.4118158774845, 6303.621782693053, 6309.968450157719, 6320.462760665395, 5783.103618939072, 5839.795607153729, 5892.234009578728, 5893.6463812171405, 5978.133170690226, 5485.286912701324, 5500.339959204921, 5501.119820828648, 5509.3664228613425, 5522.475364840334, 6265.624062556261, 6438.066480360415, 6465.77369792055, 6477.319881412383, 6495.285518593046, 6221.595596286227, 6247.156633854372, 6316.242050953915, 6318.304986451579, 6331.335209803088, 6411.775587854403, 6452.806415807533, 6486.383793539606, 6487.708053137526, 6499.415052645285, 6134.079888016655, 6222.066689996536, 6296.118543403835, 6297.370262973666, 6306.337834527309, 6124.38756124384, 6226.813195604139, 6253.0, 6263.029230469285, 6291.496680265659, 6162.661053641913, 6238.064290356483, 6244.406781355764, 6250.562460627712, 6251.9062214067735, 6080.847978800565, 6199.628022318675, 6241.812745617457, 6243.125962365181, 6268.247810262797, 5911.142884281841, 6083.6045657032155, 6133.457080270768, 6137.938620613737, 6155.938440615537, 6170.290416602148, 6202.2867370253, 6209.192804935329, 6242.28213755424, 6270.498360131087, 5956.0, 6130.969345153246, 6136.2636483622255, 6143.662098584442, 6144.139820425234], "value": 5742.244120535269, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.1165750737485, 537.5108651127472, 539.7625044980208, 548.5529293625697, 593.4807043836643, 39140.608593914054, 41438.58561414385, 41516.792416037875, 41544.37683434744, 41600.16799664005, 42354.0, 42603.78698106513, 42898.14203715924, 43001.0, 43039.78480107603, 9678.806423871536, 9776.462294573796, 9846.852297215511, 9850.9656486069, 9902.25733070019, 9751.17115045222, 9773.706788796311, 9815.607375704963, 9828.606855725799, 9831.360961537514, 9815.312928095036, 9859.852102218472, 9878.555465004056, 9887.604495820158, 9953.104220620178, 9787.314887957846, 9800.705978820612, 9808.577756225342, 9831.31180817343, 9850.802983940353, 9723.0, 9796.951015244878, 9804.607815687365, 9821.607135714563, 9828.0, 40227.79316620506, 40339.596604033875, 40602.78191654255, 40733.59266407328, 40783.796081019405, 3359.6136444308972, 3360.0087974047715, 3374.54443650109, 3444.1389652586854, 3744.588095309514, 30768.076957691304, 31251.687483125104, 31798.841005794824, 32058.839705801554, 32174.51738223905, 2927.6779554249015, 3199.856006479714, 3303.8348082596012, 3305.983470082658, 3317.0712200583876, 495380.0, 505451.0, 505561.0, 506080.0, 509099.27205823443, 59162.0, 59751.0, 59752.0, 59800.401995980355, 59812.700936495035, 34818.9554313371, 35312.47031294481, 35912.92261232167, 36486.45270320947, 36565.08587285339, 15880.761788573182, 15917.204139792964, 16023.519294421187, 16077.758833617505, 16078.598035049217, 9737.977512361242, 11942.104342174373, 12237.0, 12262.080343974238, 12378.566750163882, 15741.68516629661, 19142.0, 19332.613347732968, 19369.0, 19434.8056519433, 6484.660399894058, 7595.924040759522, 7982.640781164861, 7997.200279971957, 8010.078840933251, 727.8762610356252, 939.8496240601607, 996.4093357271182, 1005.9647912323034, 1060.5386656804314, 28512.714872851422, 29910.0, 30113.548296775567, 30944.156161365343, 31013.8449307752, 1006.5571148694551, 1029.8815636201932, 1052.1530168214508, 1072.399456304472, 1078.6494389323502, 14414.0, 14626.454561785347, 15296.694066118615, 15932.761008584881, 15944.521664350088, 678803.0, 680365.0, 680402.0, 680622.0, 680678.0, 58208.0, 58434.415655843746, 58731.0, 58784.7060764702, 58831.94016717935, 1297.9221246725226, 1341.7115320206203, 1349.7975303704523, 1352.7294541091821, 1361.101672895884, 29209.85395073011, 30224.84887575548, 30435.0, 30661.846690766404, 30693.079207623807, 43933.0, 51661.48338516717, 51664.48335516747, 52014.0, 52066.219006715684, 595487.0, 595981.0, 598506.0, 599496.0025199846, 599941.0, 26428.81070351877, 26918.59622105631, 27179.86410067937, 27309.180724577498, 27402.45195096047, 38129.809350953066, 47310.76344618255, 47497.0, 47886.28170577514, 48049.279260810414, 34380.0, 36563.45154822733, 38923.80538097292, 39547.0, 40633.59366406417, 38514.614853851104, 38923.2215355697, 40557.797211013756, 40573.594264056985, 40846.38730418987, 38656.0, 38668.6133138665, 39391.015224619616, 39433.60566394414, 39442.802785985885, 26076.0, 30230.395392091596, 31736.523952141197, 35191.824040879634, 36744.81627591845, 22319.553608928054, 24004.39989000289, 25311.240662780147, 25756.61365079488, 26086.478270434105], "value": 19777.449961004364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8512691598406, 354.45591017787694, 362.7714539839902, 364.74467872489265, 398.7906349166687, 20097.196112155514, 20996.475088122785, 21185.94070296483, 21669.566608667836, 21916.780832191675, 20882.06030728617, 20996.0, 21065.0, 21249.787502124975, 21320.4669883253, 5353.411124776271, 5924.289085309769, 6071.119687645289, 6124.326324104345, 6201.410865967726, 5338.492843179911, 6142.600730952496, 6144.877102457948, 6150.0, 6235.0, 5839.79560715375, 6018.127371531125, 6019.578629495937, 6020.969895150518, 6032.758689652431, 4797.0, 5984.401559844003, 6003.8198854034445, 6047.788327408563, 6049.818505444844, 5954.612950158225, 6076.5442591805795, 6078.574499785017, 6084.726187321581, 6105.358937311607, 13170.143940643924, 16013.35946562136, 20011.89934553599, 25417.872910635513, 26321.341966450993, 2021.8382529397613, 2538.99709614703, 2578.716341202466, 2755.1734479656025, 2984.522476403765, 9960.402375857399, 9987.70036898887, 10427.947860260727, 12366.938165309115, 15907.443239486678, 1828.8628352873588, 1840.1167439629053, 1883.7897299535528, 1889.9433017009512, 1936.6417212815675, 118749.0, 123853.38073309665, 125094.3745281277, 128019.0, 130122.0, 10652.147828173727, 10793.758717747403, 10817.808746419825, 11249.875012498685, 11502.194846360842, 14168.291585420688, 14176.645583860485, 14209.289535523183, 14214.360353784105, 14232.28838558068, 8096.554689492016, 8355.95822020886, 8377.958110209533, 8455.281301089353, 8460.746177614681, 8315.459495132796, 8315.501069935823, 8321.126281740451, 8437.74686759386, 8487.830243395221, 4067.430559721641, 4270.761479171006, 4326.6754993375625, 4385.0, 4456.9331460028125, 1669.6577201673629, 1874.6531891600098, 1915.186045930474, 1933.7582802149732, 1967.07547452697, 813.5891374855778, 898.2544488074882, 904.900460949295, 906.1301150895215, 944.9763755906157, 20180.59638807245, 20635.58728825415, 21487.785122148893, 21489.35531934013, 21501.67747483789, 914.6432891172448, 932.9207017403596, 936.5925822267335, 962.3263715399248, 964.262339310428, 10498.580056797795, 11315.490802913724, 11347.886521134684, 11347.978681918667, 11391.373474458818, 576206.0, 582825.0, 589853.0, 593292.0, 596227.0, 117410.0, 121538.0, 128779.0, 133730.32539349352, 135584.6441535572, 981.5975450065439, 998.7652901568125, 1015.7206768138673, 1024.3546565663733, 1026.8665073540542, 15597.298121584328, 17760.513528106334, 18085.547861303046, 19896.50258743543, 20230.0, 56800.763889235, 56860.71569642291, 57058.42941570531, 57810.71094644668, 58066.709666451396, 83927.0, 84642.57678711567, 84901.0, 85237.0, 85942.0, 4912.975435122945, 7236.276372362932, 7361.779146625609, 7563.886541701769, 8094.676212951416, 10665.680029599125, 12490.438695163104, 12498.125131240726, 13076.607701768582, 13245.80131298012, 11077.667669969915, 11155.832662509907, 11310.717232069264, 11310.773784524428, 11518.884811151782, 11213.271137376045, 11270.492827822603, 11423.029042531478, 11574.800787850281, 11728.70678233017, 11019.393933333744, 11285.605003824827, 11618.012468939896, 11715.0, 11753.0, 6667.733290668513, 7270.636468176675, 7354.227806080498, 7421.332080112816, 7487.737929172671, 8660.870086948828, 10258.846117308396, 11169.0, 11212.943935280271, 11621.012213961907], "value": 9564.472585921532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.846837613674, 1588.9126098064605, 1657.6270339173686, 1712.1610410898663, 1860.4418674397677, 7557.697692092316, 8059.314958228558, 8716.738497845075, 9156.0, 9165.358424910251, 7509.699612015513, 8712.0, 8914.77713057174, 8923.687670931518, 8929.062448442917, 2323.500447403808, 2328.8951997160084, 2341.625339945609, 2352.2237661571726, 2353.1293421434093, 2334.1947028275304, 2348.495073559184, 2365.9881700591473, 2372.7627237276306, 2375.275540960015, 1948.4349538633778, 2330.4290448840056, 2336.170659415908, 2341.531693661266, 2345.9560495579476, 2309.6766452696634, 2309.976900230993, 2313.3406979010983, 2319.814414846808, 2319.860808351504, 2312.9421764455856, 2313.8727369994645, 2321.4312493439047, 2322.5703244899746, 2330.196082351603, 8936.106389361077, 8940.329475289314, 8973.641054357819, 9012.729618111467, 9018.36871419001, 5257.842264732064, 5347.304850369427, 5397.433269506684, 5401.567874570025, 5427.592930530226, 3316.2372654289406, 3358.983205083959, 3585.265020670782, 3680.3375392429352, 3684.8157592120288, 1069.0752499088233, 1100.1748688483638, 1109.6393672056613, 1123.9213255072148, 1128.6230798425906, 11640.301581905112, 11685.70785730355, 11793.882061179364, 11810.523684539432, 11811.287363332269, 4398.912021759547, 4553.840615578505, 4727.267273572602, 4813.278008298713, 4843.2735089736825, 9499.810003799885, 9859.901400986042, 9967.152792012761, 9986.950065249772, 9991.850122248172, 5356.982173387044, 5364.30264065669, 5364.8122315718765, 5366.114591092504, 5367.892642147135, 4198.454200953917, 4398.076403955141, 4744.264638980963, 4855.028994201174, 4884.0, 3848.3457812171996, 3937.547182074041, 3998.640122388999, 4017.979910100431, 4042.1915616876154, 1268.7525932443084, 1271.3389037700344, 1276.4830243751296, 1277.8913792327755, 1289.220021886745, 850.8340873529726, 906.3202598051462, 942.236788201559, 951.914466230289, 956.9186619137452, 4573.405457290531, 5665.688387138664, 6008.128821320884, 6082.726277317532, 6275.309715931244, 376.38085349599754, 424.8682908298437, 429.9849505267363, 431.8877091956051, 450.27730492559624, 3914.4715463412645, 3999.6600288975765, 4131.834726610962, 4154.91690166201, 4160.916781664349, 9027.909720902839, 9260.536973151451, 10493.213009024354, 10957.671269861918, 11066.723331916766, 9720.611175552898, 9857.457839818735, 10714.517846696917, 10860.999999999842, 10887.727806804734, 8235.423520353517, 8252.711155109662, 8339.332853371716, 8367.456115352483, 8385.706500272583, 5757.165211044459, 5948.851278718067, 5985.072313791369, 6016.067509536029, 6077.088436734525, 9786.804263914824, 9893.50532473359, 9899.208063355058, 10012.299139060196, 10207.489625518843, 9864.35881667718, 10260.640877569249, 10292.845607315747, 10316.226283028653, 10430.530626121994, 7538.057742782153, 7566.924330756622, 7587.772366828784, 7589.392848572212, 7617.619119043915, 8292.253697167283, 8338.957630296212, 8348.958255208685, 8349.58252087381, 8408.159184081544, 7424.96287518559, 7499.512531685423, 7523.285287897641, 7653.234676532302, 7683.961580192064, 6297.10166512761, 7369.226231245856, 7381.963090184515, 7486.663100160615, 7561.621918903923, 6904.0, 7063.540869843444, 7065.0815393998455, 7066.787996360117, 7098.503104782616, 4963.595317475633, 5008.524190201925, 5104.872378190575, 5132.46109158533, 5160.787215004546, 5053.595712343077, 5095.592352611708, 5195.402528709247, 5210.53105220532, 5250.291210686509], "value": 4495.484564859445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.79634089069634, 269.96220529125924, 285.1758418171484, 301.35961082699265, 308.0051433868604, 4267.3598960156, 4613.9538604613945, 5017.397912250526, 5332.893342133159, 5535.695536745482, 4307.655387568995, 5157.3811142662835, 5505.807296744615, 5596.188552659862, 5615.971920140393, 3580.5166302549214, 4267.698352002638, 4278.122984788111, 4306.590873866978, 4341.979634785823, 3918.960810391902, 4214.620684138427, 4294.849680261192, 4314.288142456491, 4346.913061738764, 4097.836086556535, 4103.835846566134, 4137.482814648169, 4164.729292595986, 4201.43280657112, 3323.5347051412823, 4168.0, 4182.53992060873, 4191.098913733532, 4227.372461602275, 3006.6842981487066, 3607.5851277103206, 3615.222727113683, 3617.113807117273, 3631.8196586109357, 5283.682979021271, 5397.7031263280505, 5411.458854114597, 5425.969065877471, 5495.368032676253, 4009.919801603952, 4137.841404406771, 4226.562968590694, 4389.9464128609225, 4773.785179666923, 5789.247397838296, 5812.854678633025, 5877.529797616223, 5890.528757699374, 5891.0, 3493.6331685172945, 4028.4158796974566, 4074.5314288856866, 4094.795260237006, 4109.630133287988, 6192.81421557354, 6217.751289948396, 6291.213598300213, 6295.779647712354, 6357.141785858896, 4127.9174416511505, 4139.985703502601, 4152.979235103805, 4155.335146376565, 4158.0, 3978.244133614604, 4189.329707246887, 4189.371594260885, 4191.308434108338, 4205.831766729297, 4651.488336283006, 4873.780679869415, 4885.780139893643, 4889.951100488949, 4958.479359667183, 5208.880090780501, 5343.358796944314, 5972.313183983897, 6025.8192254232445, 6063.363346848518, 1109.7503061811028, 1197.6107764976418, 1424.508544552128, 1434.8780353670054, 1443.797868298439, 937.4890684576922, 943.6505796710769, 960.4141473701037, 967.4582233949011, 990.1781521337273, 4960.727160006234, 5551.583631227674, 5552.86117847049, 5598.048331783607, 5609.242752228479, 4972.701637901738, 5869.442402971711, 6082.787102451482, 6087.3303936566945, 6226.59527130735, 4471.032745591994, 4649.69776964503, 5504.256925315111, 5580.302462192226, 5619.690916999604, 2581.4837032593555, 2665.720099389575, 2692.8922843086057, 2761.613374127624, 2782.220978126128, 4708.529147085333, 4904.558589726942, 5139.864682543645, 5374.656335916021, 5418.566514678816, 4838.854834354975, 4998.450170481244, 5183.5593974512585, 5346.048692227309, 5355.804869276795, 4515.412996310459, 4645.9303110453375, 4670.649701272486, 4984.850454486371, 5454.61817672767, 4323.610875021263, 4458.748332092273, 5120.001599688025, 5173.92239116406, 5246.213068039825, 4246.405503229612, 5122.74386280677, 5918.526517878646, 6104.572679912363, 6226.0153501758, 6218.751249949952, 6219.284782249918, 6420.903686444801, 6499.967500162469, 6541.672916354259, 3535.027867336503, 3958.327084395602, 4019.3167161582014, 4029.738067025634, 4089.815958281944, 5872.5301975842685, 5899.852503687443, 6237.28271248794, 6252.718627661675, 6269.373062693694, 4976.5023497649945, 5616.5787565931905, 5982.132590774227, 5985.9823829948145, 6036.879262414815, 4549.9307662698575, 5183.896322073462, 5518.420565840529, 5947.821565353046, 5950.375210602998, 4768.499307572655, 4991.725455100004, 5427.453175844866, 5871.970640146772, 5927.140564618193, 5456.399796022513, 5541.251930989265, 5972.0, 5996.03196417776, 6037.219020388908, 4654.906901862011, 4921.163402221702, 5436.782528698966, 5891.617044892068, 5928.67392293428], "value": 4156.67181251858, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.6310313291787, 755.8034910923162, 788.9921100788993, 792.63142638673, 839.7487743262539, 14913.701725965488, 15786.763198552031, 15838.128902910335, 15870.68258634828, 15934.442294519695, 14451.5664530064, 14582.41670333188, 14582.979191456603, 14587.562373128796, 14601.926990365033, 808.3412019204344, 821.7411515372669, 850.3027517435705, 857.1257317536109, 857.5797859049084, 830.8712149616789, 860.8235311761106, 861.543382007537, 862.3360012790148, 867.2628265973904, 870.29071306885, 886.2599729226104, 912.543728135932, 912.9954350228239, 915.6520522201588, 862.9352798540135, 864.7146441674232, 907.541691445819, 907.8955920069177, 908.0601577367426, 652.3281020548842, 653.2357142143655, 668.0980676087291, 669.6149713914518, 669.8392385827415, 14833.777493337608, 15333.23333833315, 15426.691466170725, 15429.922850385788, 15435.922820385938, 13977.79033314501, 14033.578992630237, 14215.431382744679, 14288.642783930381, 14408.0, 11800.232984856042, 11845.0, 11962.940185299105, 12052.276863388224, 12136.635900922987, 3173.3018735878068, 3764.3412402829667, 3778.263238668433, 3785.2051069275485, 3919.862804801818, 112492.0, 113641.43179284134, 113677.9057675384, 113984.86015139826, 116347.41826290815, 10465.84301235482, 10895.782084358269, 10980.176486763525, 11204.719882002852, 11260.32438053703, 17613.647727045645, 18441.81558184401, 21775.78224217769, 21944.231951881608, 23156.073757049868, 6793.524453288322, 7981.272102405807, 8080.191980801873, 8160.918390816016, 8256.793580160544, 4401.603855653007, 4487.439070116236, 4487.596116349544, 4530.207213737583, 4660.53394660538, 3362.6637336266667, 3551.058969373118, 3578.3737845876867, 3635.345637785224, 3664.486971823947, 623.7317953280042, 697.4420463629076, 707.6461769115442, 726.3970904149543, 743.0155044565972, 572.4790440699027, 637.4517914593446, 648.8799572079087, 661.8180000499901, 666.8192720722128, 7621.695132194761, 7965.362770978308, 9039.774005649911, 9534.761630959143, 9642.855357169648, 594.8066878264582, 609.9176611157437, 640.385230179024, 641.5060403489288, 646.7865604350553, 4629.606483448877, 4649.767511624405, 4724.833822384563, 4775.2598347256235, 4786.305985632064, 97213.0, 99582.50208749055, 100230.0, 128745.3562732199, 134943.0, 92294.0, 106129.0, 126567.99999999815, 128333.0, 130484.3475782615, 107297.46351268193, 109264.45367773269, 109879.0, 113273.0, 116442.41778791221, 9747.805043898941, 9918.355306905029, 9962.203023757937, 9993.10062094415, 9993.800123997335, 63148.684256578425, 63659.0, 64489.35510644833, 65229.67385163044, 67835.0, 66106.0, 67731.0, 76732.61633691796, 80105.0, 97869.53195702213, 13282.269475178959, 13468.98982576291, 13729.725405492034, 13839.100458470168, 13982.65043373883, 14760.778588321398, 15072.37146539186, 15318.157501337533, 15492.380304787683, 15663.37346506127, 13830.654233643836, 14039.973051875304, 14075.396051730462, 14107.788383174055, 14663.413463461342, 13961.232132232419, 13983.370748316147, 14028.509002184874, 14069.577912662637, 14896.0, 13722.725545489235, 14263.07290026145, 14293.428262869369, 14308.0, 14346.139231646135, 11149.163812713916, 11316.773664526829, 11338.433078345884, 11478.540858365572, 12003.1597788154, 7417.730086997888, 9337.019612940543, 9743.707688769347, 9795.0, 10789.670100015177], "value": 7772.187673952269, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 116.0, 116.0, 118.0, 101.0, 116.0, 116.0, 118.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 170.0, 176.0, 110.0, 138.0, 164.0, 128.0, 155.0, 111.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 199.0, 207.0, 257.0, 274.0, 208.0, 177.0, 252.0, 190.0], "value": 216.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 74.0, 145.0, 60.0, 61.0, 59.0, 63.0, 134.0, 59.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 85.0, 147.0, 102.0, 99.0, 103.0, 109.0, 55.0, 77.0, 139.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 89.0, 79.0, 128.0, 92.0, 89.0, 93.0, 101.0, 135.0, 103.0], "value": 100.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 129.0, 124.0, 102.0, 101.0, 115.0, 110.0, 142.0, 128.0], "value": 115.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 112.0, 127.0, 75.0, 78.0, 122.0, 149.0, 92.0, 159.0, 105.0], "value": 109.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 89.0, 87.0, 91.0, 65.0, 58.0, 59.0, 56.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 71.0, 76.0, 65.0, 83.0, 94.0, 104.0, 103.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 87.0, 87.0, 87.0, 90.0, 86.0, 89.0, 84.0, 84.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 148.0, 126.0, 150.0, 153.0, 170.0, 160.0, 165.0, 193.0, 140.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 173.0, 173.0, 176.0, 174.0, 172.0, 173.0, 172.0, 169.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 71.0, 66.0, 70.0, 68.0, 59.0, 76.0, 94.0, 79.0], "value": 71.8, "unit": "score"}]}]} 17:12:51 INFO - Return code: 0 17:12:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:12:51 ERROR - # TBPL SUCCESS # 17:12:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:12:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:12:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:12:51 INFO - 2016-08-29 17:12:51.755 screenresolution[1665:10877] starting screenresolution argv=screenresolution get 17:12:51 INFO - 2016-08-29 17:12:51.757 screenresolution[1665:10877] Display 0: 1600x1200x32@60 17:12:51 INFO - 2016-08-29 17:12:51.763 screenresolution[1666:10880] starting screenresolution argv=screenresolution list 17:12:51 INFO - Available Modes on Display 0 17:12:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:12:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:12:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:12:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:12:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:12:51 INFO - Intel Iris: 17:12:51 INFO - Chipset Model: Intel Iris 17:12:51 INFO - Type: GPU 17:12:51 INFO - Bus: Built-In 17:12:51 INFO - VRAM (Dynamic, Max): 1536 MB 17:12:51 INFO - Vendor: Intel (0x8086) 17:12:51 INFO - Device ID: 0x0a2e 17:12:51 INFO - Revision ID: 0x0009 17:12:51 INFO - Displays: 17:12:51 INFO - Display: 17:12:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:12:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:12:51 INFO - Display Serial Number: 1600x1200 60 17:12:51 INFO - Main Display: Yes 17:12:51 INFO - Mirror: Off 17:12:51 INFO - Online: Yes 17:12:51 INFO - Rotation: Supported 17:12:51 INFO - Return code: 0 17:12:51 INFO - Running post-action listener: _resource_record_post_action 17:12:51 INFO - [mozharness: 2016-08-30 00:12:51.997620Z] Finished run-tests step (success) 17:12:51 INFO - Running post-run listener: _resource_record_post_run 17:12:52 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 33008640; Write bytes: 705898496; Read time: 313; Write time: 2031 17:12:52 INFO - TinderboxPrint: CPU usage
54.4% 17:12:52 INFO - TinderboxPrint: I/O read bytes / time
33,008,640 / 313 17:12:52 INFO - TinderboxPrint: I/O write bytes / time
705,898,496 / 2,031 17:12:52 INFO - TinderboxPrint: CPU idle
2,205.2 (45.6%) 17:12:52 INFO - TinderboxPrint: CPU system
975.8 (20.2%) 17:12:52 INFO - TinderboxPrint: CPU user
1,656.7 (34.2%) 17:12:52 INFO - TinderboxPrint: Swap in / out
434,929,664 / 0 17:12:52 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388289024; Write bytes: 381699584; Read time: 28980; Write time: 664 17:12:52 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 32070656; Write bytes: 297980416; Read time: 298; Write time: 1316 17:12:52 INFO - Running post-run listener: _upload_blobber_files 17:12:52 INFO - Blob upload gear active. 17:12:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:12:52 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 17:12:52 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'] 17:12:52 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 17:12:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:53 INFO - (blobuploader) - INFO - Done attempting. 17:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:54 INFO - (blobuploader) - INFO - Done attempting. 17:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:57 INFO - (blobuploader) - INFO - Done attempting. 17:12:57 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:57 INFO - Return code: 0 17:12:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:12:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/373aed2c92eed26eec23882e00288060df4385fd03a4887bc1f3f8dcb1c4ab1508f38616b8dd735ba465fd691e63a8ff50baa5330dd0083a912ed1865910fca8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/281d99edea054b73fe886167a58b2401e54adfd878be605bf84fefd709ff1d0b0ad81c22945caaf3b8ea110867d5efbf4de7455abebb9a1a7f027a35d04dd858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e80b67aca894ef62e112aed42d8ebfe610a865d488c51ab0076357d0a9dc616c7d6b4f401ba59a8bcbed4f3f2c9d255323318f6ee5673c23ded0c077fb82de9"} 17:12:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:12:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:12:57 INFO - Contents: 17:12:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/373aed2c92eed26eec23882e00288060df4385fd03a4887bc1f3f8dcb1c4ab1508f38616b8dd735ba465fd691e63a8ff50baa5330dd0083a912ed1865910fca8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/281d99edea054b73fe886167a58b2401e54adfd878be605bf84fefd709ff1d0b0ad81c22945caaf3b8ea110867d5efbf4de7455abebb9a1a7f027a35d04dd858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e80b67aca894ef62e112aed42d8ebfe610a865d488c51ab0076357d0a9dc616c7d6b4f401ba59a8bcbed4f3f2c9d255323318f6ee5673c23ded0c077fb82de9"} 17:12:57 INFO - Running post-run listener: copy_logs_to_upload_dir 17:12:57 INFO - Copying logs to upload dir... 17:12:57 INFO - mkdir: /builds/slave/test/build/upload/logs 17:12:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.233218 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-29 17:12:57.589948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 17:12:57.593818) ========= 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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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/373aed2c92eed26eec23882e00288060df4385fd03a4887bc1f3f8dcb1c4ab1508f38616b8dd735ba465fd691e63a8ff50baa5330dd0083a912ed1865910fca8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/281d99edea054b73fe886167a58b2401e54adfd878be605bf84fefd709ff1d0b0ad81c22945caaf3b8ea110867d5efbf4de7455abebb9a1a7f027a35d04dd858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e80b67aca894ef62e112aed42d8ebfe610a865d488c51ab0076357d0a9dc616c7d6b4f401ba59a8bcbed4f3f2c9d255323318f6ee5673c23ded0c077fb82de9"} build_url:https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/Nz5ZFaaXShO2vIyH6vzFZg/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/373aed2c92eed26eec23882e00288060df4385fd03a4887bc1f3f8dcb1c4ab1508f38616b8dd735ba465fd691e63a8ff50baa5330dd0083a912ed1865910fca8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/281d99edea054b73fe886167a58b2401e54adfd878be605bf84fefd709ff1d0b0ad81c22945caaf3b8ea110867d5efbf4de7455abebb9a1a7f027a35d04dd858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e80b67aca894ef62e112aed42d8ebfe610a865d488c51ab0076357d0a9dc616c7d6b4f401ba59a8bcbed4f3f2c9d255323318f6ee5673c23ded0c077fb82de9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 17:12:57.630403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 17:12:57.630738) ========= 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.zZvwDmpzGI/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.pJ8k6V2DUS/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.005028 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 17:12:57.679479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 17:12:57.679797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 17:12:57.680116) ========= ========= Total master_lag: 0.17 =========