builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0327 starttime: 1470566188.62 results: success (0) buildid: 20160807001853 builduid: 8d764c5a7a4245729e13375ab54726ee revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.616534) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.616906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.617177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.646181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.646462) ========= 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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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-07 03:36:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-08-07 03:36:29 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.496755 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:29.177827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:29.178134) ========= 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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.021480 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:29.242543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 03:36:29.242872) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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 d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.K82iF9ZhAb/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.AgpEGPmsEo/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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-07 03:36:29,327 truncating revision to first 12 chars 2016-08-07 03:36:29,328 Setting DEBUG logging. 2016-08-07 03:36:29,328 attempt 1/10 2016-08-07 03:36:29,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42aacfe34af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 03:36:30,295 unpacking tar archive at: fx-team-d42aacfe34af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.243189 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 03:36:30.515703) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.516032) ========= script_repo_revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.516422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.516713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.541583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-07 03:36:30.541944) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:36:30 INFO - MultiFileLogger online at 20160807 03:36:30 in /builds/slave/test 03:36:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:36:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:30 INFO - {'append_to_log': False, 03:36:30 INFO - 'base_work_dir': '/builds/slave/test', 03:36:30 INFO - 'blob_upload_branch': 'Fx-Team', 03:36:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:30 INFO - 'branch': 'Fx-Team', 03:36:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:30 INFO - 'config_files': ('talos/mac_config.py',), 03:36:30 INFO - 'default_actions': ('clobber', 03:36:30 INFO - 'read-buildbot-config', 03:36:30 INFO - 'download-and-extract', 03:36:30 INFO - 'populate-webroot', 03:36:30 INFO - 'create-virtualenv', 03:36:30 INFO - 'install', 03:36:30 INFO - 'run-tests'), 03:36:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:30 INFO - 'download_minidump_stackwalk': True, 03:36:30 INFO - 'download_symbols': 'ondemand', 03:36:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:30 INFO - 'installer_path': 'installer.exe', 03:36:30 INFO - 'log_level': 'info', 03:36:30 INFO - 'log_name': 'talos', 03:36:30 INFO - 'log_to_console': True, 03:36:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:36:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:36:30 INFO - 'opt_config_files': (), 03:36:30 INFO - 'pip_index': False, 03:36:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:30 INFO - 'cmd': ('bash', 03:36:30 INFO - '-c', 03:36:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:30 INFO - 'enabled': True, 03:36:30 INFO - 'halt_on_failure': False, 03:36:30 INFO - 'name': 'check_screen_resolution'},), 03:36:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:30 INFO - 'cmd': ('bash', 03:36:30 INFO - '-c', 03:36:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:30 INFO - 'enabled': True, 03:36:30 INFO - 'halt_on_failure': False, 03:36:30 INFO - 'name': 'check_screen_resolution'},), 03:36:30 INFO - 'run_cmd_checks_enabled': True, 03:36:30 INFO - 'sps_profile': False, 03:36:30 INFO - 'sps_profile_interval': 0, 03:36:30 INFO - 'suite': 'dromaeojs', 03:36:30 INFO - 'system_bits': '32', 03:36:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:30 INFO - 'title': 't-yosemite-r7-0327', 03:36:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:30 INFO - 'use_talos_json': True, 03:36:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:30 INFO - 'work_dir': 'build'} 03:36:30 INFO - [mozharness: 2016-08-07 10:36:30.741658Z] Running clobber step. 03:36:30 INFO - Running pre-action listener: _resource_record_pre_action 03:36:30 INFO - Running main action method: clobber 03:36:30 INFO - rmtree: /builds/slave/test/build 03:36:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:31 INFO - Running post-action listener: _resource_record_post_action 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.712542Z] Finished clobber step (success) 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.712741Z] Running read-buildbot-config step. 03:36:31 INFO - Running pre-action listener: _resource_record_pre_action 03:36:31 INFO - Running main action method: read_buildbot_config 03:36:31 INFO - Using buildbot properties: 03:36:31 INFO - { 03:36:31 INFO - "project": "", 03:36:31 INFO - "product": "firefox", 03:36:31 INFO - "script_repo_revision": "production", 03:36:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:36:31 INFO - "repository": "", 03:36:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:36:31 INFO - "buildid": "20160807001853", 03:36:31 INFO - "pgo_build": "False", 03:36:31 INFO - "basedir": "/builds/slave/test", 03:36:31 INFO - "buildnumber": 106, 03:36:31 INFO - "slavename": "t-yosemite-r7-0327", 03:36:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:36:31 INFO - "platform": "yosemite_r7", 03:36:31 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 03:36:31 INFO - "branch": "fx-team", 03:36:31 INFO - "repo_path": "integration/fx-team", 03:36:31 INFO - "revision": "d42aacfe34af25e2f5110e2ca3d24a210eabeb33", 03:36:31 INFO - "stage_platform": "macosx64", 03:36:31 INFO - "builduid": "8d764c5a7a4245729e13375ab54726ee", 03:36:31 INFO - "slavebuilddir": "test" 03:36:31 INFO - } 03:36:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 03:36:31 INFO - Running post-action listener: _resource_record_post_action 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.715718Z] Finished read-buildbot-config step (success) 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.715824Z] Running download-and-extract step. 03:36:31 INFO - Running pre-action listener: _resource_record_pre_action 03:36:31 INFO - Running main action method: download_and_extract 03:36:31 INFO - mkdir: /builds/slave/test/build/tests 03:36: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')]} 03:36:31 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 03:36:31 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:32 INFO - Downloaded 1199 bytes. 03:36:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 03:36:32 INFO - Using the following test package requirements: 03:36:32 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:36:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 03:36:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 03:36:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'jsshell-mac.zip'], 03:36:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 03:36:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:36:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 03:36:32 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 03:36:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 03:36:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 03:36:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:32 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:36:32 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:33 INFO - Downloaded 16324165 bytes. 03:36:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:36:36 INFO - Return code: 0 03:36:36 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 03:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:36 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:36:36 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:37 INFO - Downloaded 16324165 bytes. 03:36:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:36:41 INFO - Return code: 0 03:36: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')]} 03:36:41 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 03:36:41 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:43 INFO - Downloaded 14413723 bytes. 03:36:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:36:43 INFO - Return code: 0 03:36:43 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')]} 03:36:43 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:36:43 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 03:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/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 03:36:46 INFO - Downloaded 111873052 bytes. 03:36:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:36:46 INFO - mkdir: /builds/slave/test/properties 03:36:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:46 INFO - Contents: 03:36:46 INFO - build_url:https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:36:47 INFO - Running post-action listener: _resource_record_post_action 03:36:47 INFO - Running post-action listener: set_extra_try_arguments 03:36:47 INFO - [mozharness: 2016-08-07 10:36:47.864830Z] Finished download-and-extract step (success) 03:36:47 INFO - [mozharness: 2016-08-07 10:36:47.864986Z] Running populate-webroot step. 03:36:47 INFO - Running pre-action listener: _resource_record_pre_action 03:36:47 INFO - Running main action method: populate_webroot 03:36:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:47 INFO - '--tppagecycles', 03:36:47 INFO - '7'], 03:36:47 INFO - 'tests': ['tsvgm']}}, 03:36:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['damp', 'tps']}, 03:36:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'tests': ['damp', 'tps']}, 03:36:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['dromaeo_dom']}, 03:36:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['basic_compositor_video']}, 03:36:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:36:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['a11yr', 03:36:47 INFO - 'ts_paint', 03:36:47 INFO - 'tpaint', 03:36:47 INFO - 'sessionrestore', 03:36:47 INFO - 'sessionrestore_no_auto_restore', 03:36:47 INFO - 'tabpaint']}, 03:36:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:47 INFO - 'ts_paint', 03:36:47 INFO - 'tpaint', 03:36:47 INFO - 'sessionrestore', 03:36:47 INFO - 'sessionrestore_no_auto_restore', 03:36:47 INFO - 'tabpaint']}, 03:36:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:47 INFO - 'ts_paint', 03:36:47 INFO - 'tpaint', 03:36:47 INFO - 'sessionrestore', 03:36:47 INFO - 'sessionrestore_no_auto_restore', 03:36:47 INFO - 'tabpaint']}, 03:36:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:47 INFO - 'ts_paint', 03:36:47 INFO - 'tpaint', 03:36:47 INFO - 'sessionrestore', 03:36:47 INFO - 'sessionrestore_no_auto_restore', 03:36:47 INFO - 'tabpaint']}, 03:36:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['a11yr', 03:36:47 INFO - 'ts_paint', 03:36:47 INFO - 'tpaint', 03:36:47 INFO - 'sessionrestore', 03:36:47 INFO - 'sessionrestore_no_auto_restore', 03:36:47 INFO - 'tabpaint']}, 03:36:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['a11yr', 03:36:47 INFO - 'ts_paint', 03:36:47 INFO - 'tpaint', 03:36:47 INFO - 'sessionrestore', 03:36:47 INFO - 'sessionrestore_no_auto_restore', 03:36:47 INFO - 'tabpaint']}, 03:36:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['tsvgx', 03:36:47 INFO - 'tsvgr_opacity', 03:36:47 INFO - 'tart', 03:36:47 INFO - 'tscrollx', 03:36:47 INFO - 'cart']}, 03:36:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:47 INFO - 'tsvgr_opacity', 03:36:47 INFO - 'tart', 03:36:47 INFO - 'tscrollx', 03:36:47 INFO - 'cart']}, 03:36:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'talos_options': ['--disable-e10s'], 03:36:47 INFO - 'tests': ['tp5o']}, 03:36:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'tests': ['tp5o']}, 03:36:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'talos_options': ['--disable-e10s', 03:36:47 INFO - '--xperf_path', 03:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:47 INFO - 'tests': ['tp5n']}, 03:36:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:47 INFO - 'talos_options': ['--xperf_path', 03:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:47 INFO - 'tests': ['tp5n']}}, 03:36:47 INFO - 'talos.zip': {'path': '', 03:36:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:47 INFO - Running post-action listener: _resource_record_post_action 03:36:47 INFO - [mozharness: 2016-08-07 10:36:47.884123Z] Finished populate-webroot step (success) 03:36:47 INFO - [mozharness: 2016-08-07 10:36:47.884235Z] Running create-virtualenv step. 03:36:47 INFO - Running pre-action listener: _resource_record_pre_action 03:36:47 INFO - Running main action method: create_virtualenv 03:36:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:47 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 03:36:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:48 INFO - Using real prefix '/tools/python27' 03:36:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:51 INFO - Installing pip.................done. 03:36:51 INFO - Return code: 0 03:36:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:51 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:36:51 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 03:36:51 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 03:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:51 INFO - 'HOME': '/Users/cltbld', 03:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:51 INFO - 'LOGNAME': 'cltbld', 03:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:51 INFO - 'MOZ_NO_REMOTE': '1', 03:36:51 INFO - 'NO_EM_RESTART': '1', 03:36:51 INFO - 'PAGER': '/bin/cat', 03:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:51 INFO - 'PWD': '/builds/slave/test', 03:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:51 INFO - 'SHELL': '/bin/bash', 03:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:36:51 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:51 INFO - 'USER': 'cltbld', 03:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:51 INFO - 'XPC_FLAGS': '0x0', 03:36:51 INFO - 'XPC_SERVICE_NAME': '0', 03:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:51 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 03:36:51 INFO - Cleaning up... 03:36:51 INFO - Return code: 0 03:36:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:51 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:36:51 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 03:36:51 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 03:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:51 INFO - 'HOME': '/Users/cltbld', 03:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:51 INFO - 'LOGNAME': 'cltbld', 03:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:51 INFO - 'MOZ_NO_REMOTE': '1', 03:36:51 INFO - 'NO_EM_RESTART': '1', 03:36:51 INFO - 'PAGER': '/bin/cat', 03:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:51 INFO - 'PWD': '/builds/slave/test', 03:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:51 INFO - 'SHELL': '/bin/bash', 03:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:36:51 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:51 INFO - 'USER': 'cltbld', 03:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:51 INFO - 'XPC_FLAGS': '0x0', 03:36:51 INFO - 'XPC_SERVICE_NAME': '0', 03:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:52 INFO - Downloading/unpacking psutil>=3.1.1 03:36:52 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 03:36:52 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 03:36:52 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 03:36:52 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 03:36:52 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 03:36:52 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 03:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:55 INFO - Installing collected packages: psutil 03:36:55 INFO - Running setup.py install for psutil 03:36:55 INFO - building 'psutil._psutil_osx' extension 03:36:55 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 03:36:55 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 03:36:55 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 03:36:56 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 03:36:56 INFO - building 'psutil._psutil_posix' extension 03:36:56 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 03:36:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:36:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:36:56 INFO - ^ 03:36:56 INFO - 1 warning generated. 03:36:56 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 03:36:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:56 INFO - Successfully installed psutil 03:36:56 INFO - Cleaning up... 03:36:56 INFO - Return code: 0 03:36:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:56 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')]} 03:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:56 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')]} 03:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:56 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:36:56 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 03:36:56 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 03:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:56 INFO - 'HOME': '/Users/cltbld', 03:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:56 INFO - 'LOGNAME': 'cltbld', 03:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:56 INFO - 'MOZ_NO_REMOTE': '1', 03:36:56 INFO - 'NO_EM_RESTART': '1', 03:36:56 INFO - 'PAGER': '/bin/cat', 03:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:56 INFO - 'PWD': '/builds/slave/test', 03:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:56 INFO - 'SHELL': '/bin/bash', 03:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:36:56 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:56 INFO - 'USER': 'cltbld', 03:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:56 INFO - 'XPC_FLAGS': '0x0', 03:36:56 INFO - 'XPC_SERVICE_NAME': '0', 03:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:56 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 03:36:56 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 03:36:56 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 03:36:56 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 03:36:56 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 03:36:56 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 03:36:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:59 INFO - Installing collected packages: mozsystemmonitor 03:36:59 INFO - Running setup.py install for mozsystemmonitor 03:36:59 INFO - Successfully installed mozsystemmonitor 03:36:59 INFO - Cleaning up... 03:36:59 INFO - Return code: 0 03:36:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:59 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:36:59 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 03:36:59 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 03:36:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:36:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:59 INFO - 'HOME': '/Users/cltbld', 03:36:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:59 INFO - 'LOGNAME': 'cltbld', 03:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:59 INFO - 'MOZ_NO_REMOTE': '1', 03:36:59 INFO - 'NO_EM_RESTART': '1', 03:36:59 INFO - 'PAGER': '/bin/cat', 03:36:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:59 INFO - 'PWD': '/builds/slave/test', 03:36:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:59 INFO - 'SHELL': '/bin/bash', 03:36:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:36:59 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:36:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:59 INFO - 'USER': 'cltbld', 03:36:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:59 INFO - 'XPC_FLAGS': '0x0', 03:36:59 INFO - 'XPC_SERVICE_NAME': '0', 03:36:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:59 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 03:36:59 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 03:36:59 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 03:36:59 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 03:36:59 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 03:36:59 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 03:37:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:02 INFO - warning: no files found matching '*.txt' 03:37:02 INFO - no previously-included directories found matching 'build' 03:37:02 INFO - no previously-included directories found matching 'dist' 03:37:02 INFO - no previously-included directories found matching '.git*' 03:37:02 INFO - Installing collected packages: jsonschema, functools32 03:37:02 INFO - Running setup.py install for functools32 03:37:02 INFO - warning: no files found matching '*.txt' 03:37:03 INFO - no previously-included directories found matching 'build' 03:37:03 INFO - no previously-included directories found matching 'dist' 03:37:03 INFO - no previously-included directories found matching '.git*' 03:37:03 INFO - Successfully installed jsonschema functools32 03:37:03 INFO - Cleaning up... 03:37:03 INFO - Return code: 0 03:37:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:37:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:37:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:03 INFO - 'HOME': '/Users/cltbld', 03:37:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:03 INFO - 'LOGNAME': 'cltbld', 03:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:03 INFO - 'MOZ_NO_REMOTE': '1', 03:37:03 INFO - 'NO_EM_RESTART': '1', 03:37:03 INFO - 'PAGER': '/bin/cat', 03:37:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:03 INFO - 'PWD': '/builds/slave/test', 03:37:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:03 INFO - 'SHELL': '/bin/bash', 03:37:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:37:03 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:37:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:03 INFO - 'USER': 'cltbld', 03:37:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:03 INFO - 'XPC_FLAGS': '0x0', 03:37:03 INFO - 'XPC_SERVICE_NAME': '0', 03:37:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:03 INFO - Cleaning up... 03:37:03 INFO - Return code: 0 03:37:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:37:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:37:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:03 INFO - 'HOME': '/Users/cltbld', 03:37:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:03 INFO - 'LOGNAME': 'cltbld', 03:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:03 INFO - 'MOZ_NO_REMOTE': '1', 03:37:03 INFO - 'NO_EM_RESTART': '1', 03:37:03 INFO - 'PAGER': '/bin/cat', 03:37:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:03 INFO - 'PWD': '/builds/slave/test', 03:37:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:03 INFO - 'SHELL': '/bin/bash', 03:37:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:37:03 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:37:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:03 INFO - 'USER': 'cltbld', 03:37:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:03 INFO - 'XPC_FLAGS': '0x0', 03:37:03 INFO - 'XPC_SERVICE_NAME': '0', 03:37:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:03 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 03:37:03 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 03:37:03 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 03:37:03 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 03:37:03 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 03:37:03 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 03:37:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:06 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 03:37:06 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 03:37:06 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 03:37:06 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 03:37:06 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 03:37:06 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 03:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:07 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 03:37:07 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 03:37:07 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 03:37:07 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 03:37:07 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 03:37:07 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 03:37:07 INFO - Downloading docopt-0.6.1.tar.gz 03:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:07 INFO - Running setup.py install for blobuploader 03:37:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:07 INFO - Running setup.py install for requests 03:37:08 INFO - Running setup.py install for docopt 03:37:08 INFO - Successfully installed blobuploader requests docopt 03:37:08 INFO - Cleaning up... 03:37:08 INFO - Return code: 0 03:37:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:08 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:37:08 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 03:37:08 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 03:37:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:37:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:08 INFO - 'HOME': '/Users/cltbld', 03:37:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:08 INFO - 'LOGNAME': 'cltbld', 03:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:08 INFO - 'MOZ_NO_REMOTE': '1', 03:37:08 INFO - 'NO_EM_RESTART': '1', 03:37:08 INFO - 'PAGER': '/bin/cat', 03:37:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:08 INFO - 'PWD': '/builds/slave/test', 03:37:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:08 INFO - 'SHELL': '/bin/bash', 03:37:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:37:08 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:37:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:08 INFO - 'USER': 'cltbld', 03:37:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:08 INFO - 'XPC_FLAGS': '0x0', 03:37:08 INFO - 'XPC_SERVICE_NAME': '0', 03:37:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-s41tjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-lacopC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-5D0kqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-ucNV7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-PtNZBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-BqOLq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-GGZR4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-ZokcA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-y_S1VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-n9vtM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-5Nplac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-9snIKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:09 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-SLOQ_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:10 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Jd856f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:10 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-U61s5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:10 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-AurhAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:10 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Ye7Q4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:10 INFO - Running setup.py install for manifestparser 03:37:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:10 INFO - Running setup.py install for mozcrash 03:37:10 INFO - Running setup.py install for mozdebug 03:37:10 INFO - Running setup.py install for mozdevice 03:37:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Running setup.py install for mozfile 03:37:11 INFO - Running setup.py install for mozhttpd 03:37:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Running setup.py install for mozinfo 03:37:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Running setup.py install for mozInstall 03:37:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Running setup.py install for mozleak 03:37:11 INFO - Running setup.py install for mozlog 03:37:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:11 INFO - Running setup.py install for moznetwork 03:37:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:12 INFO - Running setup.py install for mozprocess 03:37:12 INFO - Running setup.py install for mozprofile 03:37:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:12 INFO - Running setup.py install for mozrunner 03:37:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:12 INFO - Running setup.py install for mozscreenshot 03:37:12 INFO - Running setup.py install for moztest 03:37:12 INFO - Running setup.py install for mozversion 03:37:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:13 INFO - Cleaning up... 03:37:13 INFO - Return code: 0 03:37:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:13 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:37:13 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 03:37:13 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 03:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:13 INFO - 'HOME': '/Users/cltbld', 03:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:13 INFO - 'LOGNAME': 'cltbld', 03:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:13 INFO - 'MOZ_NO_REMOTE': '1', 03:37:13 INFO - 'NO_EM_RESTART': '1', 03:37:13 INFO - 'PAGER': '/bin/cat', 03:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:13 INFO - 'PWD': '/builds/slave/test', 03:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:13 INFO - 'SHELL': '/bin/bash', 03:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:37:13 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:13 INFO - 'USER': 'cltbld', 03:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:13 INFO - 'XPC_FLAGS': '0x0', 03:37:13 INFO - 'XPC_SERVICE_NAME': '0', 03:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:13 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-enGs2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:13 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)) 03:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:13 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-sDDizu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:13 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)) 03:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:13 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-pzQ57S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:13 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)) 03:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:13 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-NLBjVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:13 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)) 03:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:13 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Bg4PJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:13 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)) 03:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:13 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-BohoPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:13 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)) 03:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:13 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-LxWQjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-d1DN3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-2bQtDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-FrhJ2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-vlCgUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-9Vbdxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-XbRw4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-biP3iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-9ijIg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:14 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)) 03:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:14 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-zm7BZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:15 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)) 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:15 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-gG3RkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:15 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)) 03:37:15 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)) 03:37:15 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)) 03:37:15 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)) 03:37:15 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)) 03:37:15 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)) 03:37:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:15 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 03:37:15 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 03:37:15 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 03:37:15 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 03:37:15 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 03:37:15 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 03:37:17 INFO - Downloading blessings-1.6.tar.gz 03:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:17 INFO - Installing collected packages: blessings 03:37:17 INFO - Running setup.py install for blessings 03:37:17 INFO - Successfully installed blessings 03:37:17 INFO - Cleaning up... 03:37:17 INFO - Return code: 0 03:37:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:18 INFO - Reading from file tmpfile_stdout 03:37:18 INFO - Current package versions: 03:37:18 INFO - blessings == 1.6 03:37:18 INFO - blobuploader == 1.2.4 03:37:18 INFO - docopt == 0.6.1 03:37:18 INFO - functools32 == 3.2.3-2 03:37:18 INFO - jsonschema == 2.5.1 03:37:18 INFO - manifestparser == 1.1 03:37:18 INFO - mozInstall == 1.12 03:37:18 INFO - mozcrash == 0.17 03:37:18 INFO - mozdebug == 0.1 03:37:18 INFO - mozdevice == 0.48 03:37:18 INFO - mozfile == 1.2 03:37:18 INFO - mozhttpd == 0.7 03:37:18 INFO - mozinfo == 0.9 03:37:18 INFO - mozleak == 0.1 03:37:18 INFO - mozlog == 3.3 03:37:18 INFO - moznetwork == 0.27 03:37:18 INFO - mozprocess == 0.23 03:37:18 INFO - mozprofile == 0.28 03:37:18 INFO - mozrunner == 6.12 03:37:18 INFO - mozscreenshot == 0.1 03:37:18 INFO - mozsystemmonitor == 0.3 03:37:18 INFO - moztest == 0.7 03:37:18 INFO - mozversion == 1.4 03:37:18 INFO - psutil == 3.1.1 03:37:18 INFO - requests == 1.2.3 03:37:18 INFO - wsgiref == 0.1.2 03:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:18 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:37:18 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 03:37:18 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 03:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:18 INFO - 'HOME': '/Users/cltbld', 03:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:18 INFO - 'LOGNAME': 'cltbld', 03:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:18 INFO - 'MOZ_NO_REMOTE': '1', 03:37:18 INFO - 'NO_EM_RESTART': '1', 03:37:18 INFO - 'PAGER': '/bin/cat', 03:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:18 INFO - 'PWD': '/builds/slave/test', 03:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:18 INFO - 'SHELL': '/bin/bash', 03:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:37:18 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:18 INFO - 'USER': 'cltbld', 03:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:18 INFO - 'XPC_FLAGS': '0x0', 03:37:18 INFO - 'XPC_SERVICE_NAME': '0', 03:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 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)) 03:37:18 INFO - Cleaning up... 03:37:18 INFO - Return code: 0 03:37:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:18 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 0x1014c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10155b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc21bc45d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, '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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 03:37:18 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 03:37:18 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 03:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:18 INFO - 'HOME': '/Users/cltbld', 03:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:18 INFO - 'LOGNAME': 'cltbld', 03:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:18 INFO - 'MOZ_NO_REMOTE': '1', 03:37:18 INFO - 'NO_EM_RESTART': '1', 03:37:18 INFO - 'PAGER': '/bin/cat', 03:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:18 INFO - 'PWD': '/builds/slave/test', 03:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:18 INFO - 'SHELL': '/bin/bash', 03:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:37:18 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:18 INFO - 'USER': 'cltbld', 03:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:18 INFO - 'XPC_FLAGS': '0x0', 03:37:18 INFO - 'XPC_SERVICE_NAME': '0', 03:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:18 INFO - Cleaning up... 03:37:18 INFO - Return code: 0 03:37:18 INFO - Running post-action listener: _resource_record_post_action 03:37:18 INFO - Running post-action listener: _start_resource_monitoring 03:37:18 INFO - Starting resource monitoring. 03:37:18 INFO - [mozharness: 2016-08-07 10:37:18.703754Z] Finished create-virtualenv step (success) 03:37:18 INFO - [mozharness: 2016-08-07 10:37:18.704710Z] Running install step. 03:37:18 INFO - Running pre-action listener: _resource_record_pre_action 03:37:18 INFO - Running main action method: install 03:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:18 INFO - Reading from file tmpfile_stdout 03:37:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:19 INFO - Reading from file tmpfile_stdout 03:37:19 INFO - Output received: 03:37:19 INFO - Usage: mozinstall [options] installer 03:37:19 INFO - Options: 03:37:19 INFO - -h, --help show this help message and exit 03:37:19 INFO - -d DEST, --destination=DEST 03:37:19 INFO - Directory to install application into. [default: 03:37:19 INFO - "/builds/slave/test"] 03:37:19 INFO - --app=APP Application being installed. [default: firefox] 03:37:19 INFO - mkdir: /builds/slave/test/build/application 03:37:19 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'] 03:37:19 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 03:37:53 INFO - Reading from file tmpfile_stdout 03:37:53 INFO - Output received: 03:37:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:37:53 INFO - Running post-action listener: _resource_record_post_action 03:37:53 INFO - [mozharness: 2016-08-07 10:37:53.529750Z] Finished install step (success) 03:37:53 INFO - [mozharness: 2016-08-07 10:37:53.529896Z] Running run-tests step. 03:37:53 INFO - Running pre-action listener: _resource_record_pre_action 03:37:53 INFO - Running main action method: run_tests 03:37:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:37:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:37:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:37:53 INFO - 2016-08-07 03:37:53.543 screenresolution[2655:31438] starting screenresolution argv=screenresolution get 03:37:53 INFO - 2016-08-07 03:37:53.545 screenresolution[2655:31438] Display 0: 1600x1200x32@60 03:37:53 INFO - 2016-08-07 03:37:53.550 screenresolution[2656:31440] starting screenresolution argv=screenresolution list 03:37:53 INFO - Available Modes on Display 0 03:37:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:37:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:37:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:37:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:37:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:37:53 INFO - Intel Iris: 03:37:53 INFO - Chipset Model: Intel Iris 03:37:53 INFO - Type: GPU 03:37:53 INFO - Bus: Built-In 03:37:53 INFO - VRAM (Dynamic, Max): 1536 MB 03:37:53 INFO - Vendor: Intel (0x8086) 03:37:53 INFO - Device ID: 0x0a2e 03:37:53 INFO - Revision ID: 0x0009 03:37:53 INFO - Displays: 03:37:53 INFO - Display: 03:37:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:37:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:37:53 INFO - Display Serial Number: 1600x1200 60 03:37:53 INFO - Main Display: Yes 03:37:53 INFO - Mirror: Off 03:37:53 INFO - Online: Yes 03:37:53 INFO - Rotation: Supported 03:37:53 INFO - Return code: 0 03:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:53 INFO - Python 2.7.3 03:37:53 INFO - Return code: 0 03:37:53 INFO - grabbing minidump binary from tooltool 03:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142ad30>, '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 0x10118fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101422b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:37:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:37:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:37:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:53 INFO - Return code: 0 03:37:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:37:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:37:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:53 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:37:53 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0327 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K82iF9ZhAb/Render', 03:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:53 INFO - 'HOME': '/Users/cltbld', 03:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:53 INFO - 'LOGNAME': 'cltbld', 03:37:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:53 INFO - 'MOZ_NO_REMOTE': '1', 03:37:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:53 INFO - 'NO_EM_RESTART': '1', 03:37:53 INFO - 'PAGER': '/bin/cat', 03:37:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:53 INFO - 'PWD': '/builds/slave/test', 03:37:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:53 INFO - 'SHELL': '/bin/bash', 03:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgpEGPmsEo/Listeners', 03:37:53 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 03:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:53 INFO - 'USER': 'cltbld', 03:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:53 INFO - 'XPC_FLAGS': '0x0', 03:37:53 INFO - 'XPC_SERVICE_NAME': '0', 03:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:37:54 INFO - mozversion application_buildid: 20160807001853 03:37:54 INFO - mozversion application_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 03:37:54 INFO - mozversion application_display_name: Nightly 03:37:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:54 INFO - mozversion application_name: Firefox 03:37:54 INFO - mozversion application_remotingname: firefox 03:37:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:37:54 INFO - mozversion application_vendor: Mozilla 03:37:54 INFO - mozversion application_version: 51.0a1 03:37:54 INFO - mozversion platform_buildid: 20160807001853 03:37:54 INFO - mozversion platform_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 03:37:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:37:54 INFO - mozversion platform_version: 51.0a1 03:37:54 INFO - using testdate: 1470566274 03:37:54 INFO - actual date: 1470566274 03:37:54 INFO - starting webserver on 'localhost:54559' 03:37:54 INFO - SUITE-START | Running 2 tests 03:37:54 INFO - TEST-START | dromaeo_css 03:37:54 INFO - operating with platform_type : mac_ 03:37:54 INFO - Initialising browser for dromaeo_css test... 03:37:54 INFO - TEST-INFO | started process 2666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmp9tUbYl/profile http://localhost:54559/getInfo.html) 03:37:56 INFO - PROCESS | 2666 | __metrics Screen width/height:1600/1200 03:37:56 INFO - PROCESS | 2666 | colorDepth:24 03:37:56 INFO - PROCESS | 2666 | Browser inner width/height: 1024/689 03:37:56 INFO - PROCESS | 2666 | __metrics 03:37:56 INFO - PROCESS | 2666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:37:56 INFO - PROCESS | 2666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:57 INFO - TEST-INFO | 2666: exit 0 03:37:57 INFO - Browser initialized. 03:37:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:57 INFO - TEST-INFO | started process 2668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmp9tUbYl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:09 INFO - PROCESS | 2668 | RSS: Main: 243597312 03:38:09 INFO - PROCESS | 2668 | 03:39:00 INFO - PROCESS | 2668 | 1470566340996 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] 03:41:13 INFO - PROCESS | 2668 | Cycle 1(1): loaded http://localhost:54559/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54559/tests/dromaeo/cssquery-ext.html) 03:41:14 INFO - PROCESS | 2668 | RSS: Main: 392364032 03:41:14 INFO - PROCESS | 2668 | 03:44:18 INFO - PROCESS | 2668 | Cycle 1(1): loaded http://localhost:54559/tests/dromaeo/cssquery-ext.html (next: http://localhost:54559/tests/dromaeo/cssquery-jquery.html) 03:44:18 INFO - PROCESS | 2668 | RSS: Main: 386748416 03:44:18 INFO - PROCESS | 2668 | 03:47:21 INFO - PROCESS | 2668 | Cycle 1(1): loaded http://localhost:54559/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54559/tests/dromaeo/cssquery-mootools.html) 03:47:21 INFO - PROCESS | 2668 | RSS: Main: 358973440 03:47:21 INFO - PROCESS | 2668 | 03:50:24 INFO - PROCESS | 2668 | Cycle 1(1): loaded http://localhost:54559/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54559/tests/dromaeo/cssquery-prototype.html) 03:50:24 INFO - PROCESS | 2668 | RSS: Main: 376111104 03:50:24 INFO - PROCESS | 2668 | 03:53:28 INFO - PROCESS | 2668 | Cycle 1(1): loaded http://localhost:54559/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54559/tests/dromaeo/cssquery-yui.html) 03:53:28 INFO - PROCESS | 2668 | RSS: Main: 355016704 03:53:28 INFO - PROCESS | 2668 | 03:56:31 INFO - PROCESS | 2668 | Cycle 1(1): loaded http://localhost:54559/tests/dromaeo/cssquery-yui.html (next: http://localhost:54559/tests/dromaeo/cssquery-dojo.html) 03:56:32 INFO - PROCESS | 2668 | RSS: Main: 514211840 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | __start_tp_report 03:56:32 INFO - PROCESS | 2668 | _x_x_mozilla_page_load 03:56:32 INFO - PROCESS | 2668 | _x_x_mozilla_page_load_details 03:56:32 INFO - PROCESS | 2668 | |i|pagename|runs| 03:56:32 INFO - PROCESS | 2668 | |0;dojo.html;2860.3421213120982;3352.7150192233667;3363.5627368442115;3390.254144088303;3426.366122267381;5698.515626171775;5700.857478563028;5784.219130417392;5797.971010144948;5843.2695913010875;5798.565107616935;5845.5031322337545;5976.9241536523405;5984.1921340619;6013.75944962201;5225.738713064351;5278.709670968095;5305.283786688806;5306.09796334624;5395.271638328814;5401.540869026137;5424.267723857268;5426.484483974036;5429.375621803484;5479.671219726809;5229.5293423591675;5278.81524146653;5294.629375943686;5320.255164277004;5357.116075847481;5311.973440132813;5313.9734301328635;5319.654222475566;5328.786848526054;5349.465053494659;5148.974255128738;5241.606879484016;5250.894982100336;5281.947180528184;5301.284326615896;5779.624324418899;5793.5654825887805;5794.101914203306;5807.564432667525;5808.88382232353;6239.469645080128;6278.843028924268;6285.025820997753;6292.653904035276;6306.306306306303;6175.814725558241;6238.313785483639;6274.058891166316;6321.620702757803;6322.620642761403;5986.760529578812;6008.768202518517;6053.394660534;6058;6063.272407311151;6193;6240.937590624127;6250.9062364064575;6290.150829637941;6313.147725057151;6244.094606282064;6266.530010249249;6283.717232724538;6299.874002519924;6303.936960630427;6320.71556779946;6324.430801227912;6338.619682819046;6348.301686814539;6351.079093531412;6150.384961503813;6223.253209614875;6263.123162757218;6269.780557680459;6295.5907865988565;6344.111824344595;6346.682665866688;6346.777862774781;6355;6361.840953976188;5049.772760225798;5050.621203409759;5054.949450505522;5065.138926382524;5093.23601459784;4488.887777805516;4518.615917646971;4521.977390113028;4564.109998550317;4610.838620648328;5679.630823996427;5738.254026976467;5776;5798.768049278066;5829.76680932758;6262.15460912771;6275.184226050585;6278.215223097113;6283.905741413882;6300.905486417708;5697.3448053474385;5764.193012978187;5769.105788602773;5769.88460230793;5853.590248682552;5400.351957765015;5489.34127904654;5503.7798488060025;5511.53151982086;5527.364353099365;6348.238211414659;6361.300256971729;6368.554201205871;6369.426751592287;6390.7443702251385;6183.505319574333;6292.402221788922;6293.622382657055;6306.779262725782;6313.747450101944;6186.350433204449;6273.341299163704;6296.370362963667;6371.458426033839;6388.297287298301;6250.906236406367;6291.748330066746;6308.589941653778;6308.905366419415;6319.873602528016;6207.906881396692;6280.968595157177;6285.874282514415;6291.528135389773;6323.36766323364;6072.392760723892;6132.936844521141;6169.475594574512;6232.937670623236;6275.215598050244;6208.348123447154;6233.127362169209;6244.219472565929;6263.154474145932;6279.246490421178;6106.6336019838955;6122.632642041492;6123.877522449615;6151.538634602333;6157.26112866441;6112.724927378367;6115.970584430425;6149.754009839735;6249.593776404519;6255.24937007562;6080.847978800389;6088.330283668704;6093.542984276286;6098.481629061579;6136.478399336106 03:56:32 INFO - PROCESS | 2668 | |1;ext.html;472.9361536192614;502.86674031381676;510.56346823465935;532.7442827442825;555.3474667265962;30122.698773012264;31705.36589268219;31763.888263910798;31803.36393272139;31933.68066319336;32716.509252361175;33225.667743322556;40945.18109637805;41602.7919860401;42106.157876842444;9688.273379496532;9800.852987205197;9803.2157427406;9818.214542836557;9833.01669833018;9573.473458959754;9684.176844968151;9686;9694;9724.319297649168;8726.127387261255;8909.777255568597;9685.418874867495;11664;11831.290122592673;11740;11809.88190118105;11820.527178912833;11842.822357664641;11855.525778968831;11627.476763545661;11730.706732331675;11752.58865939688;11755.11836612249;11762.470688818938;39279.41080883789;39511.60488395137;39684.80157599223;39782.80108599467;39827.40258896119;3450.430678937972;3469.2194256292387;3587.3004764070756;3673.742838001341;3717;30648.080557583307;31542.369152617048;31639.683603163903;31740.365192696016;31869.521957170662;3130.4991201407665;3314;3315.336932613463;3320.8837690680953;3360.6975372216616;468280;469270;469718;470395;472152.63923680503;55480;55824.6043848907;55896.44103558912;55996.44003559994;56012.719936400055;59633.701831490565;59634.70182649059;59670.70164649149;59714.70142649259;60041;15748.60628484297;16075.276612552463;16085.034897906164;16099.517014489584;16149.838501615068;12531.812022819666;12609.432575534123;12635.178713383784;12660.936695316464;12669.619911402673;12567.685807854694;14494.710105797825;15031.398744050333;15090.849091509164;15178.013429127072;5520.723963801875;7057.788266352018;7149.249328820503;7206.315400036988;7210.963945180345;789.8301865098916;845.457532936992;913.3287034029983;1010.545254635417;1075.8224892892742;29249.268768280537;29356.853215733783;29994.400111998075;30058.699413006027;30109;1032.9586816527406;1084.8535447714457;1085.696005118568;1153.9596114135966;1172.6364826903687;14174.929125354307;14997.70004599902;15261.6184595386;15484.92257538705;15487.767683484757;669630;677092;678550;678677;679528;57567.71216143976;57844.71077644669;57891;57959.71020144957;58112.4188758107;1237.0536539547254;1289.7678417884683;1367.8700523450257;1393.9233342166278;1405.669667628127;29287.70712292935;30643.846780765954;30648.540271896385;31089;31573.526397103604;47018.529814702786;47594.57216283517;47602.285965711235;47664.761676191396;47695.569132926066;511732.88267116854;514002;514114;514228;515085;25412.110576129748;25443.61834572446;26415.60376594391;26525.60211596789;27442.588361174996;46862.53137468718;47044;47503.52496475129;47648.99685532969;48210;37346;37759.81120094382;38358.48551808978;38495.422568662056;39135.60864391433;37782.81108594439;38546.6145338543;39230;39514.802425987684;39536;36752.448713269856;37020.62979370279;37459.62540374562;37826.43260351152;37872.810635947746;30826.383472330876;31970.68029319677;32069.2785809069;32173.03480895577;32254;24602;24872.378190544656;25060;25408.110716124847;25433.982640694165 03:56:32 INFO - PROCESS | 2668 | |2;jquery.html;348.31555992474784;358.8797752752826;373.83924912287716;379.41001742290734;395.68938383369044;15664.451744188942;16854.578635534104;20792.06435710393;21211.363659090213;21437.571248575037;21413.57172856542;21505.741897100816;21550.353489395304;21729.891350543225;22090.558188836214;5852.531797456215;5904.852378690535;6051.939480605181;6117.938820611804;6186.9381306186815;6001.9699901500435;6108.938910610881;6123.8162855114415;6140.07898815179;6141.201643786301;3621.2395396966667;4187.476565429321;4226.9154616907645;6657.201135863703;6670.3329667033395;6493.008334205114;6672.699728512204;6698.363655452724;6712.798616041527;6730.02414649873;5781.13283007548;5813.825585232407;5821.18503409523;5825.330087040003;5850.941490585083;26100.347491312677;26435;26609;26622.73377266222;26949.922003119853;2009.336918816787;2154.89225538724;2430;2495.3904731448297;2630.7632313091913;9976.850347244797;10294.17646588271;10301.587936482532;14917.552473425814;15888.76166857498;1836.0819590204896;1841.5948491331885;1841.6132612151464;1856.2946080489462;1909.284018493065;104724.47637761763;118292;124834.37582812028;125090;125319.37340313332;11169;11191.2725672831;11648.825267620992;11660.70848228784;11885.940570297093;14765.187914664797;14783.926080369745;14790.260486975609;14792.630184245265;14806.777898331533;7593.962030189924;8612.18184272493;8646.783830404165;8743.693970711121;8780.692675756318;8498.957505212435;8515.914840851636;8529.701460448854;8671.913280867237;8693.087225841196;4451.955480445219;4539.886502837389;4563.041761230179;4624.352590637313;4657.138429390574;1667.1747484995005;1853.8887666740038;1903.1055403960117;1903.7810651774946;1956.5695546979641;828.2793969246794;876.2595606712318;965.3918031640022;978.5303054533864;1023.3808545829814;21762.782372176393;21795.801230932135;21884.45288867791;21892.89053554754;21950.780492194874;833.5540485840168;946.6308139825474;954.7565370830393;980.9656662016795;986.6201512417628;9198.448093114435;9536.761580960532;11206.663800086011;11269.549218031187;11448.828267575993;541357;546111;552089;563238;568490;126938.55715049928;132053;133144.334278328;133708;137037;951.9476428796482;959.7120863740989;989.4706332112286;989.7773001074845;991.6727479931606;17820.55448613795;19284.84290942548;19318.903405482884;19325.903370483058;19504.31734889272;42356;50319.4904152876;52650.94698106093;53305.4669453316;54440;57677.71161144167;60651;79607.56343177601;85247;86248.56875715833;7681.270279323456;7872.01599800025;8250.711225107092;8258.380621453534;8421.663133474593;9245.537723113952;12664.493420263454;12948.676283092622;13070.54253101137;13461.86538134606;10618.36289822613;11107.944460277648;11162.274452160584;11305.660830175108;11561.190716649753;10046.547905344423;11133.997940185422;11241.819608940943;11351.886481135083;11613.883861161281;11413;11420.371879546705;11689.941550292195;11694.064474841822;11928.343941083323;7081.539699919489;7737.497062690907;8057.355411566943;8282.958585207036;8452.830943380975;9290.848728353101;11112.722181945515;11342.376169310437;11421.828672569753;11480.138989575647 03:56:32 INFO - PROCESS | 2668 | |3;mootools.html;1372.8627137286278;1516.4086006457483;1567.6237702951291;1767.9911600441997;1931.7681878174612;7653.540787552751;8422.705205317816;8483.745487635366;8655.307575393961;8780.956095219532;8578.528180950045;8652.740417787476;8652.826943461127;8661.783455413617;8684.739457816275;2322.477442575424;2354.482013956935;2356.7289761677457;2358.0449917783326;2364.858108513486;1978.673518869385;2264.830137739668;2346.4485845826216;2348.377679914824;2351.247600767755;2296.908123675051;2316.6061769499142;2326.081197926818;2335.381124002141;2338.6024375856146;2283.5889539882814;2304.446932736148;2309.041747674713;2310.1683393978155;2317.687112239843;2310.2260742651233;2310.330004298751;2310.607196776535;2312.6877871487304;2316.4903721181313;8616.612252448655;8663.783405414852;8745.518996455192;8749.606267717969;8757.036725960139;5046.293518907356;5106.927545215509;5114.846554603368;5255.1066318725525;5270.051390749663;3517.9648203517895;3564.9643503565153;3584.62361452049;3602.585702644177;3613.6928361089076;1066.4987455895716;1072.4852071005882;1090.3457925244868;1101.8732845722764;1104.817705078661;11255.380954047525;11359.886401136047;11383;11386.658400248005;11404.885951140548;4401.713888597231;4493.932591011137;4519.457665080211;4529.796159172845;4575.862724118282;9044.502552359683;9046.954765226263;9066.138716821892;9067.81864362709;9078.137576930181;5156.04613146569;5157.097507936096;5158.226266060046;5166;5169.560587350042;3966.702497312713;4333.090051089306;4402;4786.856394308176;4805.471398146201;3735.6077611850906;3771.4719939208535;3774.698024158061;3806.638369354907;3865.96134038656;1162.8546431696038;1166.3002198680724;1167.7664467106613;1170.80096383615;1171.8652354979115;821.6056292979404;887.4985633117268;908.8094596079158;909.7043460875242;952.8999455057258;5074.23886417033;5636.04187288162;5750.281214848144;5843.152742852348;6033.034714445667;438.0669174657958;439.9868003959886;451.3658310074351;452.46834968911395;454.538643277074;3890.3386424307937;3974.503187101612;4028.6231123637194;4030.234255491447;4040.1313717550865;9833.508324583741;10506.579736810594;10705.46472676363;10715.785684286271;10774.4074075925;10279.794404111875;10596.735081622866;10607.257491975488;10614.363138211733;10621.256512044238;8013.4791238569305;8168.754937351889;8196.303314218358;8211.548364839871;8217.753467395987;5679.8864022720145;5781.913271301018;5831.650100993954;5835.358110607915;5880.26496687914;9933.950330248303;9949.502524873873;10000.699979000641;10017.649382271586;10251.58993640246;8375.62309696053;9231.123043310874;9264.490453025148;9653.517324133905;10240.64157754475;5931.673757943355;6942.166939967236;6956.234814170336;6958.54769440005;6960;8150.225728555778;8153;8235.629396677285;8253.380996425412;8256.009278886571;7324.926750732638;7422.146453157956;7454.105507339154;7480.551166930001;7497.175310715926;6191.752329906753;7077.1507419107975;7254.854902902018;7273.636318183963;7313.524620899624;6224.128621992834;6897.9653052042595;6925.376716095576;7016.193137789015;7018.789436316919;4546.749928753818;4825.927611085906;4951.158303088411;4961.1070007397575;5063.1898896176435;4806.423229212517;4893.951060489349;4959.479254678351;5004.074246264453;5103.157978933435 03:56:32 INFO - PROCESS | 2668 | |4;prototype.html;285.1943260289682;294.82015970258146;307.3238874476153;310.06669923530194;313.06081754735794;4823.5417635324675;5293.9735301323535;5391.595630327722;5411.648242864216;5416.025115479217;3474.7317229211344;4052.4731784867927;5267.604929630284;5292.603054770889;5410.377806552247;3593.2813437312448;3889.2221555688834;4044.8179831907487;4055.6147166019327;4089.9591004089875;3406.744494162935;3862.6523612874835;4071.2875246831686;4073.6556936210977;4086.652634526069;3916.6279203475624;4014.839406423754;4048.4332193492787;4048.817803198863;4084.1423301106656;3367.579052618423;3686.5760437549757;4066.369712694537;4066.9796651016554;4074.9592504074876;3574;3574.8748793792092;3578.499010138583;3583.140046388848;3589.10272431892;4619.514950930171;4770.517522208772;5046.142155833517;5057.519535644108;5065.746712664389;3876.3991581304945;4598.609118224921;4654.394928659252;4659.603933665642;4667.8330417395655;4771.856844294677;4856.732879691615;5115.514026167508;5517.586181036399;5564.471375219388;3611.747177697562;3845.365514690073;3859.0863897757295;3909.4526766252748;3933.5839097924722;5273.630845840793;5442.374126975409;5592.832215033555;5803.65178089316;5836.649801011953;3863.9227215455535;3885.902852428712;3924.430957511202;3924.6075392460525;3929.0570263137215;3407.3185362927516;3887.280853042196;4007.0783719744622;4025.7584544926813;4045.3931910213705;3905.8047097645003;4158.480189976253;4527.162474942146;4578.816847326069;4661.067786442725;4663.160631086437;5008.398992120969;5492.725363731797;5499.835004949778;5528.198411230349;1257.3713143428286;1268.1566758105942;1337.9464821407034;1357.5587933921515;1383.868532489432;783.7492002559127;835.4820011592851;846.8687353460224;850.77913194566;851.5827244650077;3545.3618348697482;3923.489946306962;4043.0094626816617;4189.706720529533;4205.369194620831;4213.061991483891;4301.44081269433;4486.820527178941;4566.931496027562;4623.306504024423;3964.365701487748;3986.7807270600397;4106.425100485934;4180.623743863067;4187.91624167515;2158.3093410108927;2162.2324074953167;2193.594185075734;2311.919082832093;2326.719814581719;4177.43346245158;4410.78013050475;4519.276915693474;4716.85849424511;4807.807687692453;3917.43302678925;4227.231163587855;4740.597049250852;4741.2888066789565;4769.426089390562;4250.723702959298;4411.713238639542;4721.952780472151;4762.190427627312;4857.862540482177;4716.8113275468595;4748.335233067304;4754.405699287589;4754.814274436067;4788;4096.9795151024055;4126.94762835475;4234.666080184855;4596.080783843312;4731.344029589616;4009.4587230723478;4762.404699412574;4788.928166077581;5283.833628212415;5397.568194544506;3235.7573182011915;3447.637998010173;3807.9809600951817;3814.3407617686394;3815.21788033458;4713.410823647044;5197.688138711689;5290.947090529045;5534.146061069426;5723.828285151452;5246.475352464876;5489.286392768914;5510.189803200316;5523.972380138073;5581.7209139543675;4879.780409881493;5330.308194361823;5503.862403439946;5578.77684892616;5583.720813959205;4658.697184682985;4828.668218928928;5119.667221630582;5430.83707488776;5446.992306423324;4677.649176311858;5211.817586384458;5357.598180136428;5498.206237695977;5526.253955715927;4279.893002674958;5378.892422151614;5403.540699040625;5511.696856672921;5560.2493663356545 03:56:32 INFO - PROCESS | 2668 | |5;yui.html;733.7065173930428;742.6917829100923;749.6963729689478;802.6949759091547;825.3314814999846;15491.690166196684;16202.756958645601;16407.507774766746;16463.588410289747;16476.011439313635;14640.633984150401;14716.926415367934;14746.336414861331;14770.778438323434;14789.630259243524;677.1332694151494;707.1337611426013;781.8553567589986;840.0255703384045;850.6682393866381;853.7225401744427;863.6804382378529;870.8040690844541;873.2969959182856;873.4759144513305;926.8239034583441;927.8144371125768;929.7629104578323;930.6789157740569;931.5388882503171;715.2775696546526;882.1311008656468;919.6551293265026;921.7004473546091;922.6447817590209;686.8351595617066;687.2028447001504;687.8383579858729;688.2498077095989;691.3225039461356;14902.329395177243;14966;14986.47547335838;15024.624384390478;15073.397064117422;13821.51624693141;13893.305334733324;14147.434102635882;14150.575482735534;14239.430422783076;12747.936260318638;12829.55096571625;12909.225446473241;12913.096083274175;13130.34348282582;3719.237556300952;3859.4789703390243;3958.5843486434087;3976.204759048173;4734.029523947583;112867;113404.43297783459;115218;115220;115335.42332288368;10640.46797660114;10809.891901081046;10923.453827308604;10966.342019478856;11169.994700476833;20839.58320833605;20880.686789698168;20909.686354704692;20910.477238068866;20987.370378888656;7778.572178530235;7964.601769911481;8024.117347091816;8064.8387032259025;8082.555459449787;4466.620337271368;4520.254158063883;4597.103564804898;4649.256119020941;4676.392069031004;3617.855285788539;3743.1016556026357;3758.981205094012;3766.6233376662112;3774.584795672474;545.9781608735685;638.8083574927596;652.8498445357594;671.771597656799;673.7035704290097;533.3918236516905;587.3157771196509;606.087837804102;679.2799632389683;695.4679670052413;8180;8684.60919258635;9265.953670231605;9683.32216744821;9689.70930872075;586.7389011889753;598.9966805600689;606.2452246952572;621.3599992008238;698.5040621159034;4385.407969924083;4794.904101917942;4923.104604727206;4995.9500404996215;5092.796288148433;146577.26711366588;148113;150973;169897;171026;120805;129925.35037324941;131587.34206328908;140397.89403158962;143237;72096.27903721106;73828;96335;100671.98656026839;124097.75902241042;9847.803043939224;9944.801103977736;9962.352447090916;10034.247431442816;10076.798464030824;59566.106508403274;60540.69729651324;61587.692061539405;62257;64764.70470590656;92230;94492;96071.51964240134;97786;99756.00243997468;11852.229605075643;13095.607131786062;13165.934170329087;13310.068295219242;13629.38667759973;10924.2899211551;12652.17760845542;13504;13859.792103118663;14021.255227616708;11651.88348116508;13910.443582256596;14038;14160.079594826304;14290.928545357207;12775.764905306834;13736.34863748048;14112.576622701336;14233.857661423253;14327.928360358132;13372.465101395836;13603.863961360259;13829;14219.573412797632;14399.42402303896;11175.273607215506;11224.790703486193;11424.942875285571;11491;11563;8408.83182336362;10216.080552750289;11329.433528323387;11585.6524304271;11624.128190385924 03:56:32 INFO - PROCESS | 2668 | __end_tp_report 03:56:32 INFO - PROCESS | 2668 | __start_cc_report 03:56:32 INFO - PROCESS | 2668 | _x_x_mozilla_cycle_collect,1540 03:56:32 INFO - PROCESS | 2668 | __end_cc_report 03:56:32 INFO - PROCESS | 2668 | __startTimestamp1470567392090__endTimestamp 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | ------- Summary: start ------- 03:56:32 INFO - PROCESS | 2668 | Number of tests: 6 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | [#0] dojo.html Cycles:165 Average:5838.47 Median:6115.97 stddev:647.39 (10.6%) stddev-sans-first:605.76 03:56:32 INFO - PROCESS | 2668 | Values: 2860.3 3352.7 3363.6 3390.3 3426.4 5698.5 5700.9 5784.2 5798.0 5843.3 5798.6 5845.5 5976.9 5984.2 6013.8 5225.7 5278.7 5305.3 5306.1 5395.3 5401.5 5424.3 5426.5 5429.4 5479.7 5229.5 5278.8 5294.6 5320.3 5357.1 5312.0 5314.0 5319.7 5328.8 5349.5 5149.0 5241.6 5250.9 5281.9 5301.3 5779.6 5793.6 5794.1 5807.6 5808.9 6239.5 6278.8 6285.0 6292.7 6306.3 6175.8 6238.3 6274.1 6321.6 6322.6 5986.8 6008.8 6053.4 6058.0 6063.3 6193.0 6240.9 6250.9 6290.2 6313.1 6244.1 6266.5 6283.7 6299.9 6303.9 6320.7 6324.4 6338.6 6348.3 6351.1 6150.4 6223.3 6263.1 6269.8 6295.6 6344.1 6346.7 6346.8 6355.0 6361.8 5049.8 5050.6 5054.9 5065.1 5093.2 4488.9 4518.6 4522.0 4564.1 4610.8 5679.6 5738.3 5776.0 5798.8 5829.8 6262.2 6275.2 6278.2 6283.9 6300.9 5697.3 5764.2 5769.1 5769.9 5853.6 5400.4 5489.3 5503.8 5511.5 5527.4 6348.2 6361.3 6368.6 6369.4 6390.7 6183.5 6292.4 6293.6 6306.8 6313.7 6186.4 6273.3 6296.4 6371.5 6388.3 6250.9 6291.7 6308.6 6308.9 6319.9 6207.9 6281.0 6285.9 6291.5 6323.4 6072.4 6132.9 6169.5 6232.9 6275.2 6208.3 6233.1 6244.2 6263.2 6279.2 6106.6 6122.6 6123.9 6151.5 6157.3 6112.7 6116.0 6149.8 6249.6 6255.2 6080.8 6088.3 6093.5 6098.5 6136.5 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | [#1] ext.html Cycles:180 Average:68240.89 Median:36886.54 stddev:149932.91 (406.5%) stddev-sans-first:150267.18 03:56:32 INFO - PROCESS | 2668 | Values: 472.9 502.9 510.6 532.7 555.3 30122.7 31705.4 31763.9 31803.4 31933.7 32716.5 33225.7 40945.2 41602.8 42106.2 9688.3 9800.9 9803.2 9818.2 9833.0 9573.5 9684.2 9686.0 9694.0 9724.3 8726.1 8909.8 9685.4 11664.0 11831.3 11740.0 11809.9 11820.5 11842.8 11855.5 11627.5 11730.7 11752.6 11755.1 11762.5 39279.4 39511.6 39684.8 39782.8 39827.4 3450.4 3469.2 3587.3 3673.7 3717.0 30648.1 31542.4 31639.7 31740.4 31869.5 3130.5 3314.0 3315.3 3320.9 3360.7 468280.0 469270.0 469718.0 470395.0 472152.6 55480.0 55824.6 55896.4 55996.4 56012.7 59633.7 59634.7 59670.7 59714.7 60041.0 15748.6 16075.3 16085.0 16099.5 16149.8 12531.8 12609.4 12635.2 12660.9 12669.6 12567.7 14494.7 15031.4 15090.8 15178.0 5520.7 7057.8 7149.2 7206.3 7211.0 789.8 845.5 913.3 1010.5 1075.8 29249.3 29356.9 29994.4 30058.7 30109.0 1033.0 1084.9 1085.7 1154.0 1172.6 14174.9 14997.7 15261.6 15484.9 15487.8 669630.0 677092.0 678550.0 678677.0 679528.0 57567.7 57844.7 57891.0 57959.7 58112.4 1237.1 1289.8 1367.9 1393.9 1405.7 29287.7 30643.8 30648.5 31089.0 31573.5 47018.5 47594.6 47602.3 47664.8 47695.6 511732.9 514002.0 514114.0 514228.0 515085.0 25412.1 25443.6 26415.6 26525.6 27442.6 46862.5 47044.0 47503.5 47649.0 48210.0 37346.0 37759.8 38358.5 38495.4 39135.6 37782.8 38546.6 39230.0 39514.8 39536.0 36752.4 37020.6 37459.6 37826.4 37872.8 30826.4 31970.7 32069.3 32173.0 32254.0 24602.0 24872.4 25060.0 25408.1 25434.0 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | [#2] jquery.html Cycles:180 Average:33946.20 Median:13649.12 stddev:93074.82 (681.9%) stddev-sans-first:93301.73 03:56:32 INFO - PROCESS | 2668 | Values: 348.3 358.9 373.8 379.4 395.7 15664.5 16854.6 20792.1 21211.4 21437.6 21413.6 21505.7 21550.4 21729.9 22090.6 5852.5 5904.9 6051.9 6117.9 6186.9 6002.0 6108.9 6123.8 6140.1 6141.2 3621.2 4187.5 4226.9 6657.2 6670.3 6493.0 6672.7 6698.4 6712.8 6730.0 5781.1 5813.8 5821.2 5825.3 5850.9 26100.3 26435.0 26609.0 26622.7 26949.9 2009.3 2154.9 2430.0 2495.4 2630.8 9976.9 10294.2 10301.6 14917.6 15888.8 1836.1 1841.6 1841.6 1856.3 1909.3 104724.5 118292.0 124834.4 125090.0 125319.4 11169.0 11191.3 11648.8 11660.7 11885.9 14765.2 14783.9 14790.3 14792.6 14806.8 7594.0 8612.2 8646.8 8743.7 8780.7 8499.0 8515.9 8529.7 8671.9 8693.1 4452.0 4539.9 4563.0 4624.4 4657.1 1667.2 1853.9 1903.1 1903.8 1956.6 828.3 876.3 965.4 978.5 1023.4 21762.8 21795.8 21884.5 21892.9 21950.8 833.6 946.6 954.8 981.0 986.6 9198.4 9536.8 11206.7 11269.5 11448.8 541357.0 546111.0 552089.0 563238.0 568490.0 126938.6 132053.0 133144.3 133708.0 137037.0 951.9 959.7 989.5 989.8 991.7 17820.6 19284.8 19318.9 19325.9 19504.3 42356.0 50319.5 52650.9 53305.5 54440.0 57677.7 60651.0 79607.6 85247.0 86248.6 7681.3 7872.0 8250.7 8258.4 8421.7 9245.5 12664.5 12948.7 13070.5 13461.9 10618.4 11107.9 11162.3 11305.7 11561.2 10046.5 11134.0 11241.8 11351.9 11613.9 11413.0 11420.4 11689.9 11694.1 11928.3 7081.5 7737.5 8057.4 8283.0 8452.8 9290.8 11112.7 11342.4 11421.8 11480.1 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | [#3] mootools.html Cycles:180 Average:5547.64 Median:4859.94 stddev:3124.37 (64.3%) stddev-sans-first:3117.38 03:56:32 INFO - PROCESS | 2668 | Values: 1372.9 1516.4 1567.6 1768.0 1931.8 7653.5 8422.7 8483.7 8655.3 8781.0 8578.5 8652.7 8652.8 8661.8 8684.7 2322.5 2354.5 2356.7 2358.0 2364.9 1978.7 2264.8 2346.4 2348.4 2351.2 2296.9 2316.6 2326.1 2335.4 2338.6 2283.6 2304.4 2309.0 2310.2 2317.7 2310.2 2310.3 2310.6 2312.7 2316.5 8616.6 8663.8 8745.5 8749.6 8757.0 5046.3 5106.9 5114.8 5255.1 5270.1 3518.0 3565.0 3584.6 3602.6 3613.7 1066.5 1072.5 1090.3 1101.9 1104.8 11255.4 11359.9 11383.0 11386.7 11404.9 4401.7 4493.9 4519.5 4529.8 4575.9 9044.5 9047.0 9066.1 9067.8 9078.1 5156.0 5157.1 5158.2 5166.0 5169.6 3966.7 4333.1 4402.0 4786.9 4805.5 3735.6 3771.5 3774.7 3806.6 3866.0 1162.9 1166.3 1167.8 1170.8 1171.9 821.6 887.5 908.8 909.7 952.9 5074.2 5636.0 5750.3 5843.2 6033.0 438.1 440.0 451.4 452.5 454.5 3890.3 3974.5 4028.6 4030.2 4040.1 9833.5 10506.6 10705.5 10715.8 10774.4 10279.8 10596.7 10607.3 10614.4 10621.3 8013.5 8168.8 8196.3 8211.5 8217.8 5679.9 5781.9 5831.7 5835.4 5880.3 9934.0 9949.5 10000.7 10017.6 10251.6 8375.6 9231.1 9264.5 9653.5 10240.6 5931.7 6942.2 6956.2 6958.5 6960.0 8150.2 8153.0 8235.6 8253.4 8256.0 7324.9 7422.1 7454.1 7480.6 7497.2 6191.8 7077.2 7254.9 7273.6 7313.5 6224.1 6898.0 6925.4 7016.2 7018.8 4546.7 4825.9 4951.2 4961.1 5063.2 4806.4 4894.0 4959.5 5004.1 5103.2 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | [#4] prototype.html Cycles:180 Average:4186.90 Median:4547.05 stddev:1262.84 (27.8%) stddev-sans-first:1231.95 03:56:32 INFO - PROCESS | 2668 | Values: 285.2 294.8 307.3 310.1 313.1 4823.5 5294.0 5391.6 5411.6 5416.0 3474.7 4052.5 5267.6 5292.6 5410.4 3593.3 3889.2 4044.8 4055.6 4090.0 3406.7 3862.7 4071.3 4073.7 4086.7 3916.6 4014.8 4048.4 4048.8 4084.1 3367.6 3686.6 4066.4 4067.0 4075.0 3574.0 3574.9 3578.5 3583.1 3589.1 4619.5 4770.5 5046.1 5057.5 5065.7 3876.4 4598.6 4654.4 4659.6 4667.8 4771.9 4856.7 5115.5 5517.6 5564.5 3611.7 3845.4 3859.1 3909.5 3933.6 5273.6 5442.4 5592.8 5803.7 5836.6 3863.9 3885.9 3924.4 3924.6 3929.1 3407.3 3887.3 4007.1 4025.8 4045.4 3905.8 4158.5 4527.2 4578.8 4661.1 4663.2 5008.4 5492.7 5499.8 5528.2 1257.4 1268.2 1337.9 1357.6 1383.9 783.7 835.5 846.9 850.8 851.6 3545.4 3923.5 4043.0 4189.7 4205.4 4213.1 4301.4 4486.8 4566.9 4623.3 3964.4 3986.8 4106.4 4180.6 4187.9 2158.3 2162.2 2193.6 2311.9 2326.7 4177.4 4410.8 4519.3 4716.9 4807.8 3917.4 4227.2 4740.6 4741.3 4769.4 4250.7 4411.7 4722.0 4762.2 4857.9 4716.8 4748.3 4754.4 4754.8 4788.0 4097.0 4126.9 4234.7 4596.1 4731.3 4009.5 4762.4 4788.9 5283.8 5397.6 3235.8 3447.6 3808.0 3814.3 3815.2 4713.4 5197.7 5290.9 5534.1 5723.8 5246.5 5489.3 5510.2 5524.0 5581.7 4879.8 5330.3 5503.9 5578.8 5583.7 4658.7 4828.7 5119.7 5430.8 5447.0 4677.6 5211.8 5357.6 5498.2 5526.3 4279.9 5378.9 5403.5 5511.7 5560.2 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - PROCESS | 2668 | [#5] yui.html Cycles:180 Average:25033.61 Median:3751.04 stddev:40406.18 (1077.2%) stddev-sans-first:40478.33 03:56:32 INFO - PROCESS | 2668 | Values: 733.7 742.7 749.7 802.7 825.3 15491.7 16202.8 16407.5 16463.6 16476.0 14640.6 14716.9 14746.3 14770.8 14789.6 677.1 707.1 781.9 840.0 850.7 853.7 863.7 870.8 873.3 873.5 926.8 927.8 929.8 930.7 931.5 715.3 882.1 919.7 921.7 922.6 686.8 687.2 687.8 688.2 691.3 14902.3 14966.0 14986.5 15024.6 15073.4 13821.5 13893.3 14147.4 14150.6 14239.4 12747.9 12829.6 12909.2 12913.1 13130.3 3719.2 3859.5 3958.6 3976.2 4734.0 112867.0 113404.4 115218.0 115220.0 115335.4 10640.5 10809.9 10923.5 10966.3 11170.0 20839.6 20880.7 20909.7 20910.5 20987.4 7778.6 7964.6 8024.1 8064.8 8082.6 4466.6 4520.3 4597.1 4649.3 4676.4 3617.9 3743.1 3759.0 3766.6 3774.6 546.0 638.8 652.8 671.8 673.7 533.4 587.3 606.1 679.3 695.5 8180.0 8684.6 9266.0 9683.3 9689.7 586.7 599.0 606.2 621.4 698.5 4385.4 4794.9 4923.1 4996.0 5092.8 146577.3 148113.0 150973.0 169897.0 171026.0 120805.0 129925.4 131587.3 140397.9 143237.0 72096.3 73828.0 96335.0 100672.0 124097.8 9847.8 9944.8 9962.4 10034.2 10076.8 59566.1 60540.7 61587.7 62257.0 64764.7 92230.0 94492.0 96071.5 97786.0 99756.0 11852.2 13095.6 13165.9 13310.1 13629.4 10924.3 12652.2 13504.0 13859.8 14021.3 11651.9 13910.4 14038.0 14160.1 14290.9 12775.8 13736.3 14112.6 14233.9 14327.9 13372.5 13603.9 13829.0 14219.6 14399.4 11175.3 11224.8 11424.9 11491.0 11563.0 8408.8 10216.1 11329.4 11585.7 11624.1 03:56:32 INFO - PROCESS | 2668 | -------- Summary: end -------- 03:56:32 INFO - PROCESS | 2668 | 03:56:32 INFO - TEST-INFO | 2668: exit 0 03:56:32 INFO - TEST-OK | dromaeo_css | took 1118724ms 03:56:32 INFO - TEST-START | kraken 03:56:32 INFO - operating with platform_type : mac_ 03:56:32 INFO - Initialising browser for kraken test... 03:56:32 INFO - TEST-INFO | started process 2674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpN4A8uO/profile http://localhost:54559/getInfo.html) 03:56:35 INFO - PROCESS | 2674 | __metrics Screen width/height:1600/1200 03:56:35 INFO - PROCESS | 2674 | colorDepth:24 03:56:35 INFO - PROCESS | 2674 | Browser inner width/height: 1024/689 03:56:35 INFO - PROCESS | 2674 | __metrics 03:56:35 INFO - PROCESS | 2674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:56:35 INFO - PROCESS | 2674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:36 INFO - TEST-INFO | 2674: exit 0 03:56:36 INFO - Browser initialized. 03:56:36 INFO - Running cycle 1/1 for kraken test... 03:56:36 INFO - TEST-INFO | started process 2675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpN4A8uO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:48 INFO - PROCESS | 2675 | RSS: Main: 243322880 03:56:48 INFO - PROCESS | 2675 | 03:56:50 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54559/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:51 INFO - PROCESS | 2675 | RSS: Main: 294240256 03:56:51 INFO - PROCESS | 2675 | 03:56:54 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54559/tests/kraken/driver.html?testName=audio-dft) 03:56:54 INFO - PROCESS | 2675 | RSS: Main: 301563904 03:56:54 INFO - PROCESS | 2675 | 03:56:58 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54559/tests/kraken/driver.html?testName=audio-fft) 03:56:59 INFO - PROCESS | 2675 | RSS: Main: 395485184 03:56:59 INFO - PROCESS | 2675 | 03:57:01 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54559/tests/kraken/driver.html?testName=audio-oscillator) 03:57:01 INFO - PROCESS | 2675 | RSS: Main: 299286528 03:57:01 INFO - PROCESS | 2675 | 03:57:03 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54559/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:04 INFO - PROCESS | 2675 | RSS: Main: 303624192 03:57:04 INFO - PROCESS | 2675 | 03:57:07 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54559/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:07 INFO - PROCESS | 2675 | RSS: Main: 340426752 03:57:07 INFO - PROCESS | 2675 | 03:57:10 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54559/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:11 INFO - PROCESS | 2675 | RSS: Main: 341757952 03:57:11 INFO - PROCESS | 2675 | 03:57:14 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54559/tests/kraken/driver.html?testName=json-parse-financial) 03:57:14 INFO - PROCESS | 2675 | RSS: Main: 339275776 03:57:14 INFO - PROCESS | 2675 | 03:57:16 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54559/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:16 INFO - PROCESS | 2675 | RSS: Main: 312836096 03:57:16 INFO - PROCESS | 2675 | 03:57:18 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:19 INFO - PROCESS | 2675 | RSS: Main: 318439424 03:57:19 INFO - PROCESS | 2675 | 03:57:21 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:22 INFO - PROCESS | 2675 | RSS: Main: 327487488 03:57:22 INFO - PROCESS | 2675 | 03:57:25 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:25 INFO - PROCESS | 2675 | RSS: Main: 329211904 03:57:25 INFO - PROCESS | 2675 | 03:57:28 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:29 INFO - PROCESS | 2675 | RSS: Main: 330555392 03:57:29 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | Cycle 1(1): loaded http://localhost:54559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54559/tests/kraken/driver.html?testName=ai-astar) 03:57:31 INFO - PROCESS | 2675 | RSS: Main: 374009856 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | __start_tp_report 03:57:31 INFO - PROCESS | 2675 | _x_x_mozilla_page_load 03:57:31 INFO - PROCESS | 2675 | _x_x_mozilla_page_load_details 03:57:31 INFO - PROCESS | 2675 | |i|pagename|runs| 03:57:31 INFO - PROCESS | 2675 | |0;ai-astar;101;113;114;111;113;114;113;113;114;113 03:57:31 INFO - PROCESS | 2675 | |1;audio-beat-detection;143;107;106;168;105;106;133;107;140;107 03:57:31 INFO - PROCESS | 2675 | |2;audio-dft;182;185;186;185;184;181;180;183;196;219 03:57:31 INFO - PROCESS | 2675 | |3;audio-fft;78;59;66;87;60;77;88;95;100;57 03:57:31 INFO - PROCESS | 2675 | |4;audio-oscillator;85;68;100;71;71;68;97;68;67;101 03:57:31 INFO - PROCESS | 2675 | |5;imaging-gaussian-blur;90;86;91;87;89;86;90;87;90;87 03:57:31 INFO - PROCESS | 2675 | |6;imaging-darkroom;93;94;95;95;94;95;95;95;105;122 03:57:31 INFO - PROCESS | 2675 | |7;imaging-desaturate;85;86;84;87;84;83;85;85;84;86 03:57:31 INFO - PROCESS | 2675 | |8;json-parse-financial;54;53;52;52;54;53;53;53;52;54 03:57:31 INFO - PROCESS | 2675 | |9;json-stringify-tinderbox;67;65;76;72;82;75;73;71;71;71 03:57:31 INFO - PROCESS | 2675 | |10;stanford-crypto-aes;83;85;82;85;83;85;86;84;85;77 03:57:31 INFO - PROCESS | 2675 | |11;stanford-crypto-ccm;140;135;141;147;135;125;147;144;147;139 03:57:31 INFO - PROCESS | 2675 | |12;stanford-crypto-pbkdf2;164;160;217;228;165;162;168;165;164;165 03:57:31 INFO - PROCESS | 2675 | |13;stanford-crypto-sha256-iterative;66;67;66;65;61;69;81;84;79;66 03:57:31 INFO - PROCESS | 2675 | __end_tp_report 03:57:31 INFO - PROCESS | 2675 | __start_cc_report 03:57:31 INFO - PROCESS | 2675 | _x_x_mozilla_cycle_collect,2061 03:57:31 INFO - PROCESS | 2675 | __end_cc_report 03:57:31 INFO - PROCESS | 2675 | __startTimestamp1470567451527__endTimestamp 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | ------- Summary: start ------- 03:57:31 INFO - PROCESS | 2675 | Number of tests: 14 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.93 (3.5%) stddev-sans-first:0.93 03:57:31 INFO - PROCESS | 2675 | Values: 101.0 113.0 114.0 111.0 113.0 114.0 113.0 113.0 114.0 113.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:120.00 stddev:22.30 (18.6%) stddev-sans-first:22.35 03:57:31 INFO - PROCESS | 2675 | Values: 143.0 107.0 106.0 168.0 105.0 106.0 133.0 107.0 140.0 107.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#2] audio-dft Cycles:10 Average:188.10 Median:185.00 stddev:11.72 (6.3%) stddev-sans-first:12.22 03:57:31 INFO - PROCESS | 2675 | Values: 182.0 185.0 186.0 185.0 184.0 181.0 180.0 183.0 196.0 219.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#3] audio-fft Cycles:10 Average:76.70 Median:77.50 stddev:15.66 (20.2%) stddev-sans-first:16.61 03:57:31 INFO - PROCESS | 2675 | Values: 78.0 59.0 66.0 87.0 60.0 77.0 88.0 95.0 100.0 57.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:69.50 stddev:14.59 (21.0%) stddev-sans-first:15.35 03:57:31 INFO - PROCESS | 2675 | Values: 85.0 68.0 100.0 71.0 71.0 68.0 97.0 68.0 67.0 101.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.50 stddev:1.89 (2.1%) stddev-sans-first:1.90 03:57:31 INFO - PROCESS | 2675 | Values: 90.0 86.0 91.0 87.0 89.0 86.0 90.0 87.0 90.0 87.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:95.00 stddev:8.98 (9.5%) stddev-sans-first:9.32 03:57:31 INFO - PROCESS | 2675 | Values: 93.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 105.0 122.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 03:57:31 INFO - PROCESS | 2675 | Values: 85.0 86.0 84.0 87.0 84.0 83.0 85.0 85.0 84.0 86.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 03:57:31 INFO - PROCESS | 2675 | Values: 54.0 53.0 52.0 52.0 54.0 53.0 53.0 53.0 52.0 54.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:4.74 (6.5%) stddev-sans-first:4.62 03:57:31 INFO - PROCESS | 2675 | Values: 67.0 65.0 76.0 72.0 82.0 75.0 73.0 71.0 71.0 71.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:85.00 stddev:2.59 (3.1%) stddev-sans-first:2.74 03:57:31 INFO - PROCESS | 2675 | Values: 83.0 85.0 82.0 85.0 83.0 85.0 86.0 84.0 85.0 77.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:142.50 stddev:6.99 (4.9%) stddev-sans-first:7.42 03:57:31 INFO - PROCESS | 2675 | Values: 140.0 135.0 141.0 147.0 135.0 125.0 147.0 144.0 147.0 139.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:165.00 stddev:24.84 (15.1%) stddev-sans-first:25.97 03:57:31 INFO - PROCESS | 2675 | Values: 164.0 160.0 217.0 228.0 165.0 162.0 168.0 165.0 164.0 165.0 03:57:31 INFO - PROCESS | 2675 | 03:57:31 INFO - PROCESS | 2675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:68.00 stddev:7.89 (11.6%) stddev-sans-first:8.21 03:57:31 INFO - PROCESS | 2675 | Values: 66.0 67.0 66.0 65.0 61.0 69.0 81.0 84.0 79.0 66.0 03:57:31 INFO - PROCESS | 2675 | -------- Summary: end -------- 03:57:31 INFO - PROCESS | 2675 | 03:57:32 INFO - TEST-INFO | 2675: exit 0 03:57:32 INFO - TEST-OK | kraken | took 59562ms 03:57:32 INFO - SUITE-END | took 1178s 03:57:32 INFO - Completed test suite (00:19:38) 03:57:32 INFO - javascript benchmark 03:57:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2860.3421213120982, 3352.7150192233667, 3363.5627368442115, 3390.254144088303, 3426.366122267381, 5698.515626171775, 5700.857478563028, 5784.219130417392, 5797.971010144948, 5843.2695913010875, 5798.565107616935, 5845.5031322337545, 5976.9241536523405, 5984.1921340619, 6013.75944962201, 5225.738713064351, 5278.709670968095, 5305.283786688806, 5306.09796334624, 5395.271638328814, 5401.540869026137, 5424.267723857268, 5426.484483974036, 5429.375621803484, 5479.671219726809, 5229.5293423591675, 5278.81524146653, 5294.629375943686, 5320.255164277004, 5357.116075847481, 5311.973440132813, 5313.9734301328635, 5319.654222475566, 5328.786848526054, 5349.465053494659, 5148.974255128738, 5241.606879484016, 5250.894982100336, 5281.947180528184, 5301.284326615896, 5779.624324418899, 5793.5654825887805, 5794.101914203306, 5807.564432667525, 5808.88382232353, 6239.469645080128, 6278.843028924268, 6285.025820997753, 6292.653904035276, 6306.306306306303, 6175.814725558241, 6238.313785483639, 6274.058891166316, 6321.620702757803, 6322.620642761403, 5986.760529578812, 6008.768202518517, 6053.394660534, 6058.0, 6063.272407311151, 6193.0, 6240.937590624127, 6250.9062364064575, 6290.150829637941, 6313.147725057151, 6244.094606282064, 6266.530010249249, 6283.717232724538, 6299.874002519924, 6303.936960630427, 6320.71556779946, 6324.430801227912, 6338.619682819046, 6348.301686814539, 6351.079093531412, 6150.384961503813, 6223.253209614875, 6263.123162757218, 6269.780557680459, 6295.5907865988565, 6344.111824344595, 6346.682665866688, 6346.777862774781, 6355.0, 6361.840953976188, 5049.772760225798, 5050.621203409759, 5054.949450505522, 5065.138926382524, 5093.23601459784, 4488.887777805516, 4518.615917646971, 4521.977390113028, 4564.109998550317, 4610.838620648328, 5679.630823996427, 5738.254026976467, 5776.0, 5798.768049278066, 5829.76680932758, 6262.15460912771, 6275.184226050585, 6278.215223097113, 6283.905741413882, 6300.905486417708, 5697.3448053474385, 5764.193012978187, 5769.105788602773, 5769.88460230793, 5853.590248682552, 5400.351957765015, 5489.34127904654, 5503.7798488060025, 5511.53151982086, 5527.364353099365, 6348.238211414659, 6361.300256971729, 6368.554201205871, 6369.426751592287, 6390.7443702251385, 6183.505319574333, 6292.402221788922, 6293.622382657055, 6306.779262725782, 6313.747450101944, 6186.350433204449, 6273.341299163704, 6296.370362963667, 6371.458426033839, 6388.297287298301, 6250.906236406367, 6291.748330066746, 6308.589941653778, 6308.905366419415, 6319.873602528016, 6207.906881396692, 6280.968595157177, 6285.874282514415, 6291.528135389773, 6323.36766323364, 6072.392760723892, 6132.936844521141, 6169.475594574512, 6232.937670623236, 6275.215598050244, 6208.348123447154, 6233.127362169209, 6244.219472565929, 6263.154474145932, 6279.246490421178, 6106.6336019838955, 6122.632642041492, 6123.877522449615, 6151.538634602333, 6157.26112866441, 6112.724927378367, 6115.970584430425, 6149.754009839735, 6249.593776404519, 6255.24937007562, 6080.847978800389, 6088.330283668704, 6093.542984276286, 6098.481629061579, 6136.478399336106], "value": 5794.948510871334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.9361536192614, 502.86674031381676, 510.56346823465935, 532.7442827442825, 555.3474667265962, 30122.698773012264, 31705.36589268219, 31763.888263910798, 31803.36393272139, 31933.68066319336, 32716.509252361175, 33225.667743322556, 40945.18109637805, 41602.7919860401, 42106.157876842444, 9688.273379496532, 9800.852987205197, 9803.2157427406, 9818.214542836557, 9833.01669833018, 9573.473458959754, 9684.176844968151, 9686.0, 9694.0, 9724.319297649168, 8726.127387261255, 8909.777255568597, 9685.418874867495, 11664.0, 11831.290122592673, 11740.0, 11809.88190118105, 11820.527178912833, 11842.822357664641, 11855.525778968831, 11627.476763545661, 11730.706732331675, 11752.58865939688, 11755.11836612249, 11762.470688818938, 39279.41080883789, 39511.60488395137, 39684.80157599223, 39782.80108599467, 39827.40258896119, 3450.430678937972, 3469.2194256292387, 3587.3004764070756, 3673.742838001341, 3717.0, 30648.080557583307, 31542.369152617048, 31639.683603163903, 31740.365192696016, 31869.521957170662, 3130.4991201407665, 3314.0, 3315.336932613463, 3320.8837690680953, 3360.6975372216616, 468280.0, 469270.0, 469718.0, 470395.0, 472152.63923680503, 55480.0, 55824.6043848907, 55896.44103558912, 55996.44003559994, 56012.719936400055, 59633.701831490565, 59634.70182649059, 59670.70164649149, 59714.70142649259, 60041.0, 15748.60628484297, 16075.276612552463, 16085.034897906164, 16099.517014489584, 16149.838501615068, 12531.812022819666, 12609.432575534123, 12635.178713383784, 12660.936695316464, 12669.619911402673, 12567.685807854694, 14494.710105797825, 15031.398744050333, 15090.849091509164, 15178.013429127072, 5520.723963801875, 7057.788266352018, 7149.249328820503, 7206.315400036988, 7210.963945180345, 789.8301865098916, 845.457532936992, 913.3287034029983, 1010.545254635417, 1075.8224892892742, 29249.268768280537, 29356.853215733783, 29994.400111998075, 30058.699413006027, 30109.0, 1032.9586816527406, 1084.8535447714457, 1085.696005118568, 1153.9596114135966, 1172.6364826903687, 14174.929125354307, 14997.70004599902, 15261.6184595386, 15484.92257538705, 15487.767683484757, 669630.0, 677092.0, 678550.0, 678677.0, 679528.0, 57567.71216143976, 57844.71077644669, 57891.0, 57959.71020144957, 58112.4188758107, 1237.0536539547254, 1289.7678417884683, 1367.8700523450257, 1393.9233342166278, 1405.669667628127, 29287.70712292935, 30643.846780765954, 30648.540271896385, 31089.0, 31573.526397103604, 47018.529814702786, 47594.57216283517, 47602.285965711235, 47664.761676191396, 47695.569132926066, 511732.88267116854, 514002.0, 514114.0, 514228.0, 515085.0, 25412.110576129748, 25443.61834572446, 26415.60376594391, 26525.60211596789, 27442.588361174996, 46862.53137468718, 47044.0, 47503.52496475129, 47648.99685532969, 48210.0, 37346.0, 37759.81120094382, 38358.48551808978, 38495.422568662056, 39135.60864391433, 37782.81108594439, 38546.6145338543, 39230.0, 39514.802425987684, 39536.0, 36752.448713269856, 37020.62979370279, 37459.62540374562, 37826.43260351152, 37872.810635947746, 30826.383472330876, 31970.68029319677, 32069.2785809069, 32173.03480895577, 32254.0, 24602.0, 24872.378190544656, 25060.0, 25408.110716124847, 25433.982640694165], "value": 19674.117756513435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.31555992474784, 358.8797752752826, 373.83924912287716, 379.41001742290734, 395.68938383369044, 15664.451744188942, 16854.578635534104, 20792.06435710393, 21211.363659090213, 21437.571248575037, 21413.57172856542, 21505.741897100816, 21550.353489395304, 21729.891350543225, 22090.558188836214, 5852.531797456215, 5904.852378690535, 6051.939480605181, 6117.938820611804, 6186.9381306186815, 6001.9699901500435, 6108.938910610881, 6123.8162855114415, 6140.07898815179, 6141.201643786301, 3621.2395396966667, 4187.476565429321, 4226.9154616907645, 6657.201135863703, 6670.3329667033395, 6493.008334205114, 6672.699728512204, 6698.363655452724, 6712.798616041527, 6730.02414649873, 5781.13283007548, 5813.825585232407, 5821.18503409523, 5825.330087040003, 5850.941490585083, 26100.347491312677, 26435.0, 26609.0, 26622.73377266222, 26949.922003119853, 2009.336918816787, 2154.89225538724, 2430.0, 2495.3904731448297, 2630.7632313091913, 9976.850347244797, 10294.17646588271, 10301.587936482532, 14917.552473425814, 15888.76166857498, 1836.0819590204896, 1841.5948491331885, 1841.6132612151464, 1856.2946080489462, 1909.284018493065, 104724.47637761763, 118292.0, 124834.37582812028, 125090.0, 125319.37340313332, 11169.0, 11191.2725672831, 11648.825267620992, 11660.70848228784, 11885.940570297093, 14765.187914664797, 14783.926080369745, 14790.260486975609, 14792.630184245265, 14806.777898331533, 7593.962030189924, 8612.18184272493, 8646.783830404165, 8743.693970711121, 8780.692675756318, 8498.957505212435, 8515.914840851636, 8529.701460448854, 8671.913280867237, 8693.087225841196, 4451.955480445219, 4539.886502837389, 4563.041761230179, 4624.352590637313, 4657.138429390574, 1667.1747484995005, 1853.8887666740038, 1903.1055403960117, 1903.7810651774946, 1956.5695546979641, 828.2793969246794, 876.2595606712318, 965.3918031640022, 978.5303054533864, 1023.3808545829814, 21762.782372176393, 21795.801230932135, 21884.45288867791, 21892.89053554754, 21950.780492194874, 833.5540485840168, 946.6308139825474, 954.7565370830393, 980.9656662016795, 986.6201512417628, 9198.448093114435, 9536.761580960532, 11206.663800086011, 11269.549218031187, 11448.828267575993, 541357.0, 546111.0, 552089.0, 563238.0, 568490.0, 126938.55715049928, 132053.0, 133144.334278328, 133708.0, 137037.0, 951.9476428796482, 959.7120863740989, 989.4706332112286, 989.7773001074845, 991.6727479931606, 17820.55448613795, 19284.84290942548, 19318.903405482884, 19325.903370483058, 19504.31734889272, 42356.0, 50319.4904152876, 52650.94698106093, 53305.4669453316, 54440.0, 57677.71161144167, 60651.0, 79607.56343177601, 85247.0, 86248.56875715833, 7681.270279323456, 7872.01599800025, 8250.711225107092, 8258.380621453534, 8421.663133474593, 9245.537723113952, 12664.493420263454, 12948.676283092622, 13070.54253101137, 13461.86538134606, 10618.36289822613, 11107.944460277648, 11162.274452160584, 11305.660830175108, 11561.190716649753, 10046.547905344423, 11133.997940185422, 11241.819608940943, 11351.886481135083, 11613.883861161281, 11413.0, 11420.371879546705, 11689.941550292195, 11694.064474841822, 11928.343941083323, 7081.539699919489, 7737.497062690907, 8057.355411566943, 8282.958585207036, 8452.830943380975, 9290.848728353101, 11112.722181945515, 11342.376169310437, 11421.828672569753, 11480.138989575647], "value": 9628.300515133718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.8627137286278, 1516.4086006457483, 1567.6237702951291, 1767.9911600441997, 1931.7681878174612, 7653.540787552751, 8422.705205317816, 8483.745487635366, 8655.307575393961, 8780.956095219532, 8578.528180950045, 8652.740417787476, 8652.826943461127, 8661.783455413617, 8684.739457816275, 2322.477442575424, 2354.482013956935, 2356.7289761677457, 2358.0449917783326, 2364.858108513486, 1978.673518869385, 2264.830137739668, 2346.4485845826216, 2348.377679914824, 2351.247600767755, 2296.908123675051, 2316.6061769499142, 2326.081197926818, 2335.381124002141, 2338.6024375856146, 2283.5889539882814, 2304.446932736148, 2309.041747674713, 2310.1683393978155, 2317.687112239843, 2310.2260742651233, 2310.330004298751, 2310.607196776535, 2312.6877871487304, 2316.4903721181313, 8616.612252448655, 8663.783405414852, 8745.518996455192, 8749.606267717969, 8757.036725960139, 5046.293518907356, 5106.927545215509, 5114.846554603368, 5255.1066318725525, 5270.051390749663, 3517.9648203517895, 3564.9643503565153, 3584.62361452049, 3602.585702644177, 3613.6928361089076, 1066.4987455895716, 1072.4852071005882, 1090.3457925244868, 1101.8732845722764, 1104.817705078661, 11255.380954047525, 11359.886401136047, 11383.0, 11386.658400248005, 11404.885951140548, 4401.713888597231, 4493.932591011137, 4519.457665080211, 4529.796159172845, 4575.862724118282, 9044.502552359683, 9046.954765226263, 9066.138716821892, 9067.81864362709, 9078.137576930181, 5156.04613146569, 5157.097507936096, 5158.226266060046, 5166.0, 5169.560587350042, 3966.702497312713, 4333.090051089306, 4402.0, 4786.856394308176, 4805.471398146201, 3735.6077611850906, 3771.4719939208535, 3774.698024158061, 3806.638369354907, 3865.96134038656, 1162.8546431696038, 1166.3002198680724, 1167.7664467106613, 1170.80096383615, 1171.8652354979115, 821.6056292979404, 887.4985633117268, 908.8094596079158, 909.7043460875242, 952.8999455057258, 5074.23886417033, 5636.04187288162, 5750.281214848144, 5843.152742852348, 6033.034714445667, 438.0669174657958, 439.9868003959886, 451.3658310074351, 452.46834968911395, 454.538643277074, 3890.3386424307937, 3974.503187101612, 4028.6231123637194, 4030.234255491447, 4040.1313717550865, 9833.508324583741, 10506.579736810594, 10705.46472676363, 10715.785684286271, 10774.4074075925, 10279.794404111875, 10596.735081622866, 10607.257491975488, 10614.363138211733, 10621.256512044238, 8013.4791238569305, 8168.754937351889, 8196.303314218358, 8211.548364839871, 8217.753467395987, 5679.8864022720145, 5781.913271301018, 5831.650100993954, 5835.358110607915, 5880.26496687914, 9933.950330248303, 9949.502524873873, 10000.699979000641, 10017.649382271586, 10251.58993640246, 8375.62309696053, 9231.123043310874, 9264.490453025148, 9653.517324133905, 10240.64157754475, 5931.673757943355, 6942.166939967236, 6956.234814170336, 6958.54769440005, 6960.0, 8150.225728555778, 8153.0, 8235.629396677285, 8253.380996425412, 8256.009278886571, 7324.926750732638, 7422.146453157956, 7454.105507339154, 7480.551166930001, 7497.175310715926, 6191.752329906753, 7077.1507419107975, 7254.854902902018, 7273.636318183963, 7313.524620899624, 6224.128621992834, 6897.9653052042595, 6925.376716095576, 7016.193137789015, 7018.789436316919, 4546.749928753818, 4825.927611085906, 4951.158303088411, 4961.1070007397575, 5063.1898896176435, 4806.423229212517, 4893.951060489349, 4959.479254678351, 5004.074246264453, 5103.157978933435], "value": 4392.164984731317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.1943260289682, 294.82015970258146, 307.3238874476153, 310.06669923530194, 313.06081754735794, 4823.5417635324675, 5293.9735301323535, 5391.595630327722, 5411.648242864216, 5416.025115479217, 3474.7317229211344, 4052.4731784867927, 5267.604929630284, 5292.603054770889, 5410.377806552247, 3593.2813437312448, 3889.2221555688834, 4044.8179831907487, 4055.6147166019327, 4089.9591004089875, 3406.744494162935, 3862.6523612874835, 4071.2875246831686, 4073.6556936210977, 4086.652634526069, 3916.6279203475624, 4014.839406423754, 4048.4332193492787, 4048.817803198863, 4084.1423301106656, 3367.579052618423, 3686.5760437549757, 4066.369712694537, 4066.9796651016554, 4074.9592504074876, 3574.0, 3574.8748793792092, 3578.499010138583, 3583.140046388848, 3589.10272431892, 4619.514950930171, 4770.517522208772, 5046.142155833517, 5057.519535644108, 5065.746712664389, 3876.3991581304945, 4598.609118224921, 4654.394928659252, 4659.603933665642, 4667.8330417395655, 4771.856844294677, 4856.732879691615, 5115.514026167508, 5517.586181036399, 5564.471375219388, 3611.747177697562, 3845.365514690073, 3859.0863897757295, 3909.4526766252748, 3933.5839097924722, 5273.630845840793, 5442.374126975409, 5592.832215033555, 5803.65178089316, 5836.649801011953, 3863.9227215455535, 3885.902852428712, 3924.430957511202, 3924.6075392460525, 3929.0570263137215, 3407.3185362927516, 3887.280853042196, 4007.0783719744622, 4025.7584544926813, 4045.3931910213705, 3905.8047097645003, 4158.480189976253, 4527.162474942146, 4578.816847326069, 4661.067786442725, 4663.160631086437, 5008.398992120969, 5492.725363731797, 5499.835004949778, 5528.198411230349, 1257.3713143428286, 1268.1566758105942, 1337.9464821407034, 1357.5587933921515, 1383.868532489432, 783.7492002559127, 835.4820011592851, 846.8687353460224, 850.77913194566, 851.5827244650077, 3545.3618348697482, 3923.489946306962, 4043.0094626816617, 4189.706720529533, 4205.369194620831, 4213.061991483891, 4301.44081269433, 4486.820527178941, 4566.931496027562, 4623.306504024423, 3964.365701487748, 3986.7807270600397, 4106.425100485934, 4180.623743863067, 4187.91624167515, 2158.3093410108927, 2162.2324074953167, 2193.594185075734, 2311.919082832093, 2326.719814581719, 4177.43346245158, 4410.78013050475, 4519.276915693474, 4716.85849424511, 4807.807687692453, 3917.43302678925, 4227.231163587855, 4740.597049250852, 4741.2888066789565, 4769.426089390562, 4250.723702959298, 4411.713238639542, 4721.952780472151, 4762.190427627312, 4857.862540482177, 4716.8113275468595, 4748.335233067304, 4754.405699287589, 4754.814274436067, 4788.0, 4096.9795151024055, 4126.94762835475, 4234.666080184855, 4596.080783843312, 4731.344029589616, 4009.4587230723478, 4762.404699412574, 4788.928166077581, 5283.833628212415, 5397.568194544506, 3235.7573182011915, 3447.637998010173, 3807.9809600951817, 3814.3407617686394, 3815.21788033458, 4713.410823647044, 5197.688138711689, 5290.947090529045, 5534.146061069426, 5723.828285151452, 5246.475352464876, 5489.286392768914, 5510.189803200316, 5523.972380138073, 5581.7209139543675, 4879.780409881493, 5330.308194361823, 5503.862403439946, 5578.77684892616, 5583.720813959205, 4658.697184682985, 4828.668218928928, 5119.667221630582, 5430.83707488776, 5446.992306423324, 4677.649176311858, 5211.817586384458, 5357.598180136428, 5498.206237695977, 5526.253955715927, 4279.893002674958, 5378.892422151614, 5403.540699040625, 5511.696856672921, 5560.2493663356545], "value": 3794.5387865762855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.7065173930428, 742.6917829100923, 749.6963729689478, 802.6949759091547, 825.3314814999846, 15491.690166196684, 16202.756958645601, 16407.507774766746, 16463.588410289747, 16476.011439313635, 14640.633984150401, 14716.926415367934, 14746.336414861331, 14770.778438323434, 14789.630259243524, 677.1332694151494, 707.1337611426013, 781.8553567589986, 840.0255703384045, 850.6682393866381, 853.7225401744427, 863.6804382378529, 870.8040690844541, 873.2969959182856, 873.4759144513305, 926.8239034583441, 927.8144371125768, 929.7629104578323, 930.6789157740569, 931.5388882503171, 715.2775696546526, 882.1311008656468, 919.6551293265026, 921.7004473546091, 922.6447817590209, 686.8351595617066, 687.2028447001504, 687.8383579858729, 688.2498077095989, 691.3225039461356, 14902.329395177243, 14966.0, 14986.47547335838, 15024.624384390478, 15073.397064117422, 13821.51624693141, 13893.305334733324, 14147.434102635882, 14150.575482735534, 14239.430422783076, 12747.936260318638, 12829.55096571625, 12909.225446473241, 12913.096083274175, 13130.34348282582, 3719.237556300952, 3859.4789703390243, 3958.5843486434087, 3976.204759048173, 4734.029523947583, 112867.0, 113404.43297783459, 115218.0, 115220.0, 115335.42332288368, 10640.46797660114, 10809.891901081046, 10923.453827308604, 10966.342019478856, 11169.994700476833, 20839.58320833605, 20880.686789698168, 20909.686354704692, 20910.477238068866, 20987.370378888656, 7778.572178530235, 7964.601769911481, 8024.117347091816, 8064.8387032259025, 8082.555459449787, 4466.620337271368, 4520.254158063883, 4597.103564804898, 4649.256119020941, 4676.392069031004, 3617.855285788539, 3743.1016556026357, 3758.981205094012, 3766.6233376662112, 3774.584795672474, 545.9781608735685, 638.8083574927596, 652.8498445357594, 671.771597656799, 673.7035704290097, 533.3918236516905, 587.3157771196509, 606.087837804102, 679.2799632389683, 695.4679670052413, 8180.0, 8684.60919258635, 9265.953670231605, 9683.32216744821, 9689.70930872075, 586.7389011889753, 598.9966805600689, 606.2452246952572, 621.3599992008238, 698.5040621159034, 4385.407969924083, 4794.904101917942, 4923.104604727206, 4995.9500404996215, 5092.796288148433, 146577.26711366588, 148113.0, 150973.0, 169897.0, 171026.0, 120805.0, 129925.35037324941, 131587.34206328908, 140397.89403158962, 143237.0, 72096.27903721106, 73828.0, 96335.0, 100671.98656026839, 124097.75902241042, 9847.803043939224, 9944.801103977736, 9962.352447090916, 10034.247431442816, 10076.798464030824, 59566.106508403274, 60540.69729651324, 61587.692061539405, 62257.0, 64764.70470590656, 92230.0, 94492.0, 96071.51964240134, 97786.0, 99756.00243997468, 11852.229605075643, 13095.607131786062, 13165.934170329087, 13310.068295219242, 13629.38667759973, 10924.2899211551, 12652.17760845542, 13504.0, 13859.792103118663, 14021.255227616708, 11651.88348116508, 13910.443582256596, 14038.0, 14160.079594826304, 14290.928545357207, 12775.764905306834, 13736.34863748048, 14112.576622701336, 14233.857661423253, 14327.928360358132, 13372.465101395836, 13603.863961360259, 13829.0, 14219.573412797632, 14399.42402303896, 11175.273607215506, 11224.790703486193, 11424.942875285571, 11491.0, 11563.0, 8408.83182336362, 10216.080552750289, 11329.433528323387, 11585.6524304271, 11624.128190385924], "value": 7872.634411375387, "unit": "score"}], "name": "dromaeo_css", "value": 7240.198710994132, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 114.0, 111.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 106.0, 168.0, 105.0, 106.0, 133.0, 107.0, 140.0, 107.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 186.0, 185.0, 184.0, 181.0, 180.0, 183.0, 196.0, 219.0], "value": 188.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 66.0, 87.0, 60.0, 77.0, 88.0, 95.0, 100.0, 57.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 68.0, 100.0, 71.0, 71.0, 68.0, 97.0, 68.0, 67.0, 101.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 91.0, 87.0, 89.0, 86.0, 90.0, 87.0, 90.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 105.0, 122.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 87.0, 84.0, 83.0, 85.0, 85.0, 84.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 54.0, 53.0, 53.0, 53.0, 52.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 76.0, 72.0, 82.0, 75.0, 73.0, 71.0, 71.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 82.0, 85.0, 83.0, 85.0, 86.0, 84.0, 85.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 141.0, 147.0, 135.0, 125.0, 147.0, 144.0, 147.0, 139.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 217.0, 228.0, 165.0, 162.0, 168.0, 165.0, 164.0, 165.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 61.0, 69.0, 81.0, 84.0, 79.0, 66.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1444.9999999999998, "alertThreshold": 2.0}]} 03:57:32 INFO - Return code: 0 03:57:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:32 INFO - # TBPL SUCCESS # 03:57:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:57:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:57:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:57:32 INFO - 2016-08-07 03:57:32.835 screenresolution[2679:33393] starting screenresolution argv=screenresolution get 03:57:32 INFO - 2016-08-07 03:57:32.837 screenresolution[2679:33393] Display 0: 1600x1200x32@60 03:57:32 INFO - 2016-08-07 03:57:32.844 screenresolution[2680:33396] starting screenresolution argv=screenresolution list 03:57:32 INFO - Available Modes on Display 0 03:57:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:57:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:57:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:57:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:57:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:57:33 INFO - Intel Iris: 03:57:33 INFO - Chipset Model: Intel Iris 03:57:33 INFO - Type: GPU 03:57:33 INFO - Bus: Built-In 03:57:33 INFO - VRAM (Dynamic, Max): 1536 MB 03:57:33 INFO - Vendor: Intel (0x8086) 03:57:33 INFO - Device ID: 0x0a2e 03:57:33 INFO - Revision ID: 0x0009 03:57:33 INFO - Displays: 03:57:33 INFO - Display: 03:57:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:57:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:57:33 INFO - Display Serial Number: 1600x1200 60 03:57:33 INFO - Main Display: Yes 03:57:33 INFO - Mirror: Off 03:57:33 INFO - Online: Yes 03:57:33 INFO - Rotation: Supported 03:57:33 INFO - Return code: 0 03:57:33 INFO - Running post-action listener: _resource_record_post_action 03:57:33 INFO - [mozharness: 2016-08-07 10:57:33.081088Z] Finished run-tests step (success) 03:57:33 INFO - Running post-run listener: _resource_record_post_run 03:57:33 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 765952; Write bytes: 703557120; Read time: 6; Write time: 1962 03:57:33 INFO - TinderboxPrint: CPU usage
53.8% 03:57:33 INFO - TinderboxPrint: I/O read bytes / time
765,952 / 6 03:57:33 INFO - TinderboxPrint: I/O write bytes / time
703,557,120 / 1,962 03:57:33 INFO - TinderboxPrint: CPU idle
2,242.0 (46.2%) 03:57:33 INFO - TinderboxPrint: CPU system
978.6 (20.2%) 03:57:33 INFO - TinderboxPrint: CPU user
1,633.1 (33.6%) 03:57:33 INFO - TinderboxPrint: Swap in / out
406,859,776 / 0 03:57:33 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389777920; Write bytes: 383951360; Read time: 29095; Write time: 825 03:57:33 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 765952; Write bytes: 292992000; Read time: 6; Write time: 1070 03:57:33 INFO - Running post-run listener: _upload_blobber_files 03:57:33 INFO - Blob upload gear active. 03:57:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:33 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 03:57:33 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'] 03:57:33 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 03:57:34 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:57:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:34 INFO - (blobuploader) - INFO - Done attempting. 03:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:36 INFO - (blobuploader) - INFO - Done attempting. 03:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:38 INFO - (blobuploader) - INFO - Done attempting. 03:57:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:38 INFO - Return code: 0 03:57:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2667e45388ba27d111eb6c9e348a93c8882432f49f0fc2b1c9e156895f3ff1df855e2d5c55adf28764e03f1b47f923efb5e18b629e5a8f6b6e22573aaf9a13e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92be2b2d48130b2019abfd34370f3f698c08767a83d0d51bd29979af9fe9ec477a376281a70d1a34fb975ae75f1542790eebc0c2b9e2018b170acab1fcbeccb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcef0bab0f6ab81e92fe1787c863c6c70c00bc14cdb758f38775a8fa4a496e5fbb291b0d5dae4c1919bda5b804578d76821f19e6449bb916d9b4ad094d36af8"} 03:57:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:38 INFO - Contents: 03:57:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2667e45388ba27d111eb6c9e348a93c8882432f49f0fc2b1c9e156895f3ff1df855e2d5c55adf28764e03f1b47f923efb5e18b629e5a8f6b6e22573aaf9a13e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92be2b2d48130b2019abfd34370f3f698c08767a83d0d51bd29979af9fe9ec477a376281a70d1a34fb975ae75f1542790eebc0c2b9e2018b170acab1fcbeccb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcef0bab0f6ab81e92fe1787c863c6c70c00bc14cdb758f38775a8fa4a496e5fbb291b0d5dae4c1919bda5b804578d76821f19e6449bb916d9b4ad094d36af8"} 03:57:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:38 INFO - Copying logs to upload dir... 03:57:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.123089 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-07 03:57:38.931950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:38.937042) ========= 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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2667e45388ba27d111eb6c9e348a93c8882432f49f0fc2b1c9e156895f3ff1df855e2d5c55adf28764e03f1b47f923efb5e18b629e5a8f6b6e22573aaf9a13e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92be2b2d48130b2019abfd34370f3f698c08767a83d0d51bd29979af9fe9ec477a376281a70d1a34fb975ae75f1542790eebc0c2b9e2018b170acab1fcbeccb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcef0bab0f6ab81e92fe1787c863c6c70c00bc14cdb758f38775a8fa4a496e5fbb291b0d5dae4c1919bda5b804578d76821f19e6449bb916d9b4ad094d36af8"} build_url:https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011597 build_url: 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2667e45388ba27d111eb6c9e348a93c8882432f49f0fc2b1c9e156895f3ff1df855e2d5c55adf28764e03f1b47f923efb5e18b629e5a8f6b6e22573aaf9a13e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92be2b2d48130b2019abfd34370f3f698c08767a83d0d51bd29979af9fe9ec477a376281a70d1a34fb975ae75f1542790eebc0c2b9e2018b170acab1fcbeccb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcef0bab0f6ab81e92fe1787c863c6c70c00bc14cdb758f38775a8fa4a496e5fbb291b0d5dae4c1919bda5b804578d76821f19e6449bb916d9b4ad094d36af8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:38.974862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:38.975203) ========= 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.K82iF9ZhAb/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.AgpEGPmsEo/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.005381 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:39.025366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 03:57:39.027279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 03:57:39.027868) ========= ========= Total master_lag: 0.45 =========