builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0381 starttime: 1470644356.77 results: success (0) buildid: 20160807230447 builduid: e8366f6d32c64222a57bcf1bbb41d0b2 revision: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:16.769279) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:16.769676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:16.769960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:16.794971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:16.795442) ========= 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.5AljK5yn9w/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.RcnY60MImg/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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-08 01:19:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.4M=0s 2016-08-08 01:19:16 (26.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:16.951147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:16.951467) ========= 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.5AljK5yn9w/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.RcnY60MImg/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.025560 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:17.003537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:17.004102) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 --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 c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AljK5yn9w/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.RcnY60MImg/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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-08 01:19:17,089 truncating revision to first 12 chars 2016-08-08 01:19:17,089 Setting DEBUG logging. 2016-08-08 01:19:17,090 attempt 1/10 2016-08-08 01:19:17,090 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c0e4639e98b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 01:19:17,749 unpacking tar archive at: fx-team-c0e4639e98b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927336 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:17.953509) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:17.953834) ========= script_repo_revision: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:17.954245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:17.954507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 01:19:17.972945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 01:19:17.973339) ========= /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.5AljK5yn9w/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.RcnY60MImg/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:18 INFO - MultiFileLogger online at 20160808 01:19:18 in /builds/slave/test 01:19:18 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 01:19:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:19:18 INFO - {'append_to_log': False, 01:19:18 INFO - 'base_work_dir': '/builds/slave/test', 01:19:18 INFO - 'blob_upload_branch': 'Fx-Team', 01:19:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:19:18 INFO - 'branch': 'Fx-Team', 01:19:18 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:18 INFO - 'config_files': ('talos/mac_config.py',), 01:19:18 INFO - 'default_actions': ('clobber', 01:19:18 INFO - 'read-buildbot-config', 01:19:18 INFO - 'download-and-extract', 01:19:18 INFO - 'populate-webroot', 01:19:18 INFO - 'create-virtualenv', 01:19:18 INFO - 'install', 01:19:18 INFO - 'run-tests'), 01:19:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:18 INFO - 'download_minidump_stackwalk': True, 01:19:18 INFO - 'download_symbols': 'ondemand', 01:19:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:18 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:18 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:18 INFO - 'installer_path': 'installer.exe', 01:19:18 INFO - 'log_level': 'info', 01:19:18 INFO - 'log_name': 'talos', 01:19:18 INFO - 'log_to_console': True, 01:19:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:19:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:19:18 INFO - 'opt_config_files': (), 01:19:18 INFO - 'pip_index': False, 01:19:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:19:18 INFO - 'cmd': ('bash', 01:19:18 INFO - '-c', 01:19:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:19:18 INFO - 'enabled': True, 01:19:18 INFO - 'halt_on_failure': False, 01:19:18 INFO - 'name': 'check_screen_resolution'},), 01:19:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:19:18 INFO - 'cmd': ('bash', 01:19:18 INFO - '-c', 01:19:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:19:18 INFO - 'enabled': True, 01:19:18 INFO - 'halt_on_failure': False, 01:19:18 INFO - 'name': 'check_screen_resolution'},), 01:19:18 INFO - 'run_cmd_checks_enabled': True, 01:19:18 INFO - 'sps_profile': False, 01:19:18 INFO - 'sps_profile_interval': 0, 01:19:18 INFO - 'suite': 'dromaeojs', 01:19:18 INFO - 'system_bits': '32', 01:19:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:18 INFO - 'title': 't-yosemite-r7-0381', 01:19:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:18 INFO - 'use_talos_json': True, 01:19:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:19:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:18 INFO - 'work_dir': 'build'} 01:19:18 INFO - [mozharness: 2016-08-08 08:19:18.170266Z] Running clobber step. 01:19:18 INFO - Running pre-action listener: _resource_record_pre_action 01:19:18 INFO - Running main action method: clobber 01:19:18 INFO - rmtree: /builds/slave/test/build 01:19:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:19:20 INFO - Running post-action listener: _resource_record_post_action 01:19:20 INFO - [mozharness: 2016-08-08 08:19:20.178176Z] Finished clobber step (success) 01:19:20 INFO - [mozharness: 2016-08-08 08:19:20.178311Z] Running read-buildbot-config step. 01:19:20 INFO - Running pre-action listener: _resource_record_pre_action 01:19:20 INFO - Running main action method: read_buildbot_config 01:19:20 INFO - Using buildbot properties: 01:19:20 INFO - { 01:19:20 INFO - "project": "", 01:19:20 INFO - "product": "firefox", 01:19:20 INFO - "script_repo_revision": "production", 01:19:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:19:20 INFO - "repository": "", 01:19:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:19:20 INFO - "buildid": "20160807230447", 01:19:20 INFO - "pgo_build": "False", 01:19:20 INFO - "basedir": "/builds/slave/test", 01:19:20 INFO - "buildnumber": 0, 01:19:20 INFO - "slavename": "t-yosemite-r7-0381", 01:19:20 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:19:20 INFO - "platform": "yosemite_r7", 01:19:20 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 01:19:20 INFO - "branch": "fx-team", 01:19:20 INFO - "repo_path": "integration/fx-team", 01:19:20 INFO - "revision": "c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7", 01:19:20 INFO - "stage_platform": "macosx64", 01:19:20 INFO - "builduid": "e8366f6d32c64222a57bcf1bbb41d0b2", 01:19:20 INFO - "slavebuilddir": "test" 01:19:20 INFO - } 01:19:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 01:19:20 INFO - Running post-action listener: _resource_record_post_action 01:19:20 INFO - [mozharness: 2016-08-08 08:19:20.181531Z] Finished read-buildbot-config step (success) 01:19:20 INFO - [mozharness: 2016-08-08 08:19:20.181639Z] Running download-and-extract step. 01:19:20 INFO - Running pre-action listener: _resource_record_pre_action 01:19:20 INFO - Running main action method: download_and_extract 01:19:20 INFO - mkdir: /builds/slave/test/build/tests 01:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:20 INFO - trying https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 01:19:20 INFO - Downloading https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:21 INFO - Downloaded 1199 bytes. 01:19:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 01:19:21 INFO - Using the following test package requirements: 01:19:21 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:19:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 01:19:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 01:19:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'jsshell-mac.zip'], 01:19:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 01:19:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:19:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 01:19:21 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 01:19:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 01:19:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:19:21 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 01:19:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:21 INFO - trying https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:19:21 INFO - Downloading https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:22 INFO - Downloaded 16324217 bytes. 01:19:22 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'] 01:19:22 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 01:19:25 INFO - Return code: 0 01:19:25 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 01:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:25 INFO - trying https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:19:25 INFO - Downloading https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:26 INFO - Downloaded 16324217 bytes. 01:19:26 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'] 01:19:26 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 01:19:29 INFO - Return code: 0 01:19:29 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')]} 01:19:29 INFO - trying https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 01:19:29 INFO - Downloading https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:30 INFO - Downloaded 14413723 bytes. 01:19:30 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'] 01:19:30 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 01:19:30 INFO - Return code: 0 01:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:30 INFO - trying https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:19:30 INFO - Downloading https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 01:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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 01:19:33 INFO - Downloaded 111870586 bytes. 01:19:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:19:33 INFO - mkdir: /builds/slave/test/properties 01:19:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:19:33 INFO - Writing to file /builds/slave/test/properties/build_url 01:19:33 INFO - Contents: 01:19:33 INFO - build_url:https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:19:34 INFO - Running post-action listener: _resource_record_post_action 01:19:34 INFO - Running post-action listener: set_extra_try_arguments 01:19:34 INFO - [mozharness: 2016-08-08 08:19:34.343624Z] Finished download-and-extract step (success) 01:19:34 INFO - [mozharness: 2016-08-08 08:19:34.343778Z] Running populate-webroot step. 01:19:34 INFO - Running pre-action listener: _resource_record_pre_action 01:19:34 INFO - Running main action method: populate_webroot 01:19:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:34 INFO - '--tppagecycles', 01:19:34 INFO - '7'], 01:19:34 INFO - 'tests': ['tsvgm']}}, 01:19:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:19:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:19:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:19:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['damp', 'tps']}, 01:19:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'tests': ['damp', 'tps']}, 01:19:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['dromaeo_dom']}, 01:19:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['basic_compositor_video']}, 01:19:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:19:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['a11yr', 01:19:34 INFO - 'ts_paint', 01:19:34 INFO - 'tpaint', 01:19:34 INFO - 'sessionrestore', 01:19:34 INFO - 'sessionrestore_no_auto_restore', 01:19:34 INFO - 'tabpaint']}, 01:19:34 INFO - 'other-e10s': {'tests': ['a11yr', 01:19:34 INFO - 'ts_paint', 01:19:34 INFO - 'tpaint', 01:19:34 INFO - 'sessionrestore', 01:19:34 INFO - 'sessionrestore_no_auto_restore', 01:19:34 INFO - 'tabpaint']}, 01:19:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:19:34 INFO - 'ts_paint', 01:19:34 INFO - 'tpaint', 01:19:34 INFO - 'sessionrestore', 01:19:34 INFO - 'sessionrestore_no_auto_restore', 01:19:34 INFO - 'tabpaint']}, 01:19:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:19:34 INFO - 'ts_paint', 01:19:34 INFO - 'tpaint', 01:19:34 INFO - 'sessionrestore', 01:19:34 INFO - 'sessionrestore_no_auto_restore', 01:19:34 INFO - 'tabpaint']}, 01:19:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['a11yr', 01:19:34 INFO - 'ts_paint', 01:19:34 INFO - 'tpaint', 01:19:34 INFO - 'sessionrestore', 01:19:34 INFO - 'sessionrestore_no_auto_restore', 01:19:34 INFO - 'tabpaint']}, 01:19:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['a11yr', 01:19:34 INFO - 'ts_paint', 01:19:34 INFO - 'tpaint', 01:19:34 INFO - 'sessionrestore', 01:19:34 INFO - 'sessionrestore_no_auto_restore', 01:19:34 INFO - 'tabpaint']}, 01:19:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['tsvgx', 01:19:34 INFO - 'tsvgr_opacity', 01:19:34 INFO - 'tart', 01:19:34 INFO - 'tscrollx', 01:19:34 INFO - 'cart']}, 01:19:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:19:34 INFO - 'tsvgr_opacity', 01:19:34 INFO - 'tart', 01:19:34 INFO - 'tscrollx', 01:19:34 INFO - 'cart']}, 01:19:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'talos_options': ['--disable-e10s'], 01:19:34 INFO - 'tests': ['tp5o']}, 01:19:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'tests': ['tp5o']}, 01:19:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'talos_options': ['--disable-e10s', 01:19:34 INFO - '--xperf_path', 01:19:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:34 INFO - 'tests': ['tp5n']}, 01:19:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:34 INFO - 'talos_options': ['--xperf_path', 01:19:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:34 INFO - 'tests': ['tp5n']}}, 01:19:34 INFO - 'talos.zip': {'path': '', 01:19:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:34 INFO - Running post-action listener: _resource_record_post_action 01:19:34 INFO - [mozharness: 2016-08-08 08:19:34.362442Z] Finished populate-webroot step (success) 01:19:34 INFO - [mozharness: 2016-08-08 08:19:34.362573Z] Running create-virtualenv step. 01:19:34 INFO - Running pre-action listener: _resource_record_pre_action 01:19:34 INFO - Running main action method: create_virtualenv 01:19:34 INFO - Creating virtualenv /builds/slave/test/build/venv 01:19:34 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 01:19:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:19:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:19:34 INFO - Using real prefix '/tools/python27' 01:19:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:19:35 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:38 INFO - Installing pip.................done. 01:19:38 INFO - Return code: 0 01:19:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:19:38 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')]} 01:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 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')]} 01:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:38 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 01:19:38 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 01:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:38 INFO - 'HOME': '/Users/cltbld', 01:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:38 INFO - 'LOGNAME': 'cltbld', 01:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:38 INFO - 'MOZ_NO_REMOTE': '1', 01:19:38 INFO - 'NO_EM_RESTART': '1', 01:19:38 INFO - 'PAGER': '/bin/cat', 01:19:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:38 INFO - 'PWD': '/builds/slave/test', 01:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:38 INFO - 'SHELL': '/bin/bash', 01:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:38 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:38 INFO - 'USER': 'cltbld', 01:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:38 INFO - 'XPC_FLAGS': '0x0', 01:19:38 INFO - 'XPC_SERVICE_NAME': '0', 01:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:38 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 01:19:38 INFO - Cleaning up... 01:19:38 INFO - Return code: 0 01:19:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:19:38 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')]} 01:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 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')]} 01:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:38 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:38 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 01:19:38 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 01:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:38 INFO - 'HOME': '/Users/cltbld', 01:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:38 INFO - 'LOGNAME': 'cltbld', 01:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:38 INFO - 'MOZ_NO_REMOTE': '1', 01:19:38 INFO - 'NO_EM_RESTART': '1', 01:19:38 INFO - 'PAGER': '/bin/cat', 01:19:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:38 INFO - 'PWD': '/builds/slave/test', 01:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:38 INFO - 'SHELL': '/bin/bash', 01:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:38 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:38 INFO - 'USER': 'cltbld', 01:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:38 INFO - 'XPC_FLAGS': '0x0', 01:19:38 INFO - 'XPC_SERVICE_NAME': '0', 01:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:38 INFO - Downloading/unpacking psutil>=3.1.1 01:19:38 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 01:19:38 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 01:19:38 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 01:19:38 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 01:19:38 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 01:19:38 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 01:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:19:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:41 INFO - Installing collected packages: psutil 01:19:41 INFO - Running setup.py install for psutil 01:19:41 INFO - building 'psutil._psutil_osx' extension 01:19:41 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 01:19:42 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 01:19:42 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 01:19:42 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 01:19:42 INFO - building 'psutil._psutil_posix' extension 01:19:42 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 01:19:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:19:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:19:42 INFO - ^ 01:19:42 INFO - 1 warning generated. 01:19:42 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 01:19:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:42 INFO - Successfully installed psutil 01:19:42 INFO - Cleaning up... 01:19:42 INFO - Return code: 0 01:19:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:42 INFO - 'HOME': '/Users/cltbld', 01:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:42 INFO - 'LOGNAME': 'cltbld', 01:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:42 INFO - 'MOZ_NO_REMOTE': '1', 01:19:42 INFO - 'NO_EM_RESTART': '1', 01:19:42 INFO - 'PAGER': '/bin/cat', 01:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:42 INFO - 'PWD': '/builds/slave/test', 01:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:42 INFO - 'SHELL': '/bin/bash', 01:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:42 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:42 INFO - 'USER': 'cltbld', 01:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:42 INFO - 'XPC_FLAGS': '0x0', 01:19:42 INFO - 'XPC_SERVICE_NAME': '0', 01:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19:43 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 01:19:43 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 01:19:43 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 01:19:43 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 01:19:43 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 01:19:43 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 01:19:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:19:45 INFO - Installing collected packages: mozsystemmonitor 01:19:45 INFO - Running setup.py install for mozsystemmonitor 01:19:45 INFO - Successfully installed mozsystemmonitor 01:19:45 INFO - Cleaning up... 01:19:45 INFO - Return code: 0 01:19:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:45 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:45 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 01:19:45 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 01:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:45 INFO - 'HOME': '/Users/cltbld', 01:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:45 INFO - 'LOGNAME': 'cltbld', 01:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:45 INFO - 'MOZ_NO_REMOTE': '1', 01:19:45 INFO - 'NO_EM_RESTART': '1', 01:19:45 INFO - 'PAGER': '/bin/cat', 01:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:45 INFO - 'PWD': '/builds/slave/test', 01:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:45 INFO - 'SHELL': '/bin/bash', 01:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:45 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:45 INFO - 'USER': 'cltbld', 01:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:45 INFO - 'XPC_FLAGS': '0x0', 01:19:45 INFO - 'XPC_SERVICE_NAME': '0', 01:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:46 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:46 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 01:19:46 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 01:19:46 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 01:19:46 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 01:19:46 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 01:19:46 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 01:19:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:48 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 01:19:48 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 01:19:48 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 01:19:48 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 01:19:48 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 01:19:48 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 01:19:49 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:49 INFO - warning: no files found matching '*.txt' 01:19:49 INFO - no previously-included directories found matching 'build' 01:19:49 INFO - no previously-included directories found matching 'dist' 01:19:49 INFO - no previously-included directories found matching '.git*' 01:19:49 INFO - Installing collected packages: jsonschema, functools32 01:19:49 INFO - Running setup.py install for functools32 01:19:49 INFO - warning: no files found matching '*.txt' 01:19:49 INFO - no previously-included directories found matching 'build' 01:19:49 INFO - no previously-included directories found matching 'dist' 01:19:49 INFO - no previously-included directories found matching '.git*' 01:19:49 INFO - Successfully installed jsonschema functools32 01:19:49 INFO - Cleaning up... 01:19:49 INFO - Return code: 0 01:19:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:49 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:49 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 01:19:49 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 01:19:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:49 INFO - 'HOME': '/Users/cltbld', 01:19:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:49 INFO - 'LOGNAME': 'cltbld', 01:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:49 INFO - 'MOZ_NO_REMOTE': '1', 01:19:49 INFO - 'NO_EM_RESTART': '1', 01:19:49 INFO - 'PAGER': '/bin/cat', 01:19:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:49 INFO - 'PWD': '/builds/slave/test', 01:19:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:49 INFO - 'SHELL': '/bin/bash', 01:19:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:49 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:49 INFO - 'USER': 'cltbld', 01:19:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:49 INFO - 'XPC_FLAGS': '0x0', 01:19:49 INFO - 'XPC_SERVICE_NAME': '0', 01:19:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:19:49 INFO - Cleaning up... 01:19:49 INFO - Return code: 0 01:19:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:49 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:49 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 01:19:49 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 01:19:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:49 INFO - 'HOME': '/Users/cltbld', 01:19:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:49 INFO - 'LOGNAME': 'cltbld', 01:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:49 INFO - 'MOZ_NO_REMOTE': '1', 01:19:49 INFO - 'NO_EM_RESTART': '1', 01:19:49 INFO - 'PAGER': '/bin/cat', 01:19:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:49 INFO - 'PWD': '/builds/slave/test', 01:19:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:49 INFO - 'SHELL': '/bin/bash', 01:19:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:49 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:49 INFO - 'USER': 'cltbld', 01:19:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:49 INFO - 'XPC_FLAGS': '0x0', 01:19:49 INFO - 'XPC_SERVICE_NAME': '0', 01:19:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:19:49 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 01:19:49 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 01:19:49 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 01:19:49 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 01:19:49 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 01:19:49 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 01:19:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19: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 01:19: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 01:19: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 01:19: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 01:19: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 01:19: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 01:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 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 01:19:53 INFO - Downloading docopt-0.6.1.tar.gz 01:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:53 INFO - Running setup.py install for blobuploader 01:19:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:53 INFO - Running setup.py install for requests 01:19:54 INFO - Running setup.py install for docopt 01:19:54 INFO - Successfully installed blobuploader requests docopt 01:19:54 INFO - Cleaning up... 01:19:54 INFO - Return code: 0 01:19:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:54 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')]} 01:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:54 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')]} 01:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:54 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:54 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 01:19:54 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 01:19:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:54 INFO - 'HOME': '/Users/cltbld', 01:19:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:54 INFO - 'LOGNAME': 'cltbld', 01:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:54 INFO - 'MOZ_NO_REMOTE': '1', 01:19:54 INFO - 'NO_EM_RESTART': '1', 01:19:54 INFO - 'PAGER': '/bin/cat', 01:19:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:54 INFO - 'PWD': '/builds/slave/test', 01:19:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:54 INFO - 'SHELL': '/bin/bash', 01:19:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:54 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:54 INFO - 'USER': 'cltbld', 01:19:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:54 INFO - 'XPC_FLAGS': '0x0', 01:19:54 INFO - 'XPC_SERVICE_NAME': '0', 01:19:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-vlRpVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-ZgTNqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-I0ifwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Y5mEh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-fkhl1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-9eni9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-dVTW31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-8dLv57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-kRAiDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-MEsevb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-nV0XRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:55 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-4uZzsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:56 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-A7KPd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:56 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-SIY1Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:56 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-QZNl8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:56 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Jo8_hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:56 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-9mE2LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:56 INFO - Running setup.py install for manifestparser 01:19:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:56 INFO - Running setup.py install for mozcrash 01:19:56 INFO - Running setup.py install for mozdebug 01:19:56 INFO - Running setup.py install for mozdevice 01:19:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozfile 01:19:57 INFO - Running setup.py install for mozhttpd 01:19:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozinfo 01:19:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozInstall 01:19:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:57 INFO - Running setup.py install for mozleak 01:19:57 INFO - Running setup.py install for mozlog 01:19:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:58 INFO - Running setup.py install for moznetwork 01:19:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:58 INFO - Running setup.py install for mozprocess 01:19:58 INFO - Running setup.py install for mozprofile 01:19:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:58 INFO - Running setup.py install for mozrunner 01:19:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:58 INFO - Running setup.py install for mozscreenshot 01:19:58 INFO - Running setup.py install for moztest 01:19:58 INFO - Running setup.py install for mozversion 01:19:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:59 INFO - Cleaning up... 01:19:59 INFO - Return code: 0 01:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19: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')]} 01:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19: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')]} 01:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:59 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:19:59 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 01:19:59 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 01:19:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:19:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:59 INFO - 'HOME': '/Users/cltbld', 01:19:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:59 INFO - 'LOGNAME': 'cltbld', 01:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:59 INFO - 'MOZ_NO_REMOTE': '1', 01:19:59 INFO - 'NO_EM_RESTART': '1', 01:19:59 INFO - 'PAGER': '/bin/cat', 01:19:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:59 INFO - 'PWD': '/builds/slave/test', 01:19:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:59 INFO - 'SHELL': '/bin/bash', 01:19:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:19:59 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:19:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:59 INFO - 'USER': 'cltbld', 01:19:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:59 INFO - 'XPC_FLAGS': '0x0', 01:19:59 INFO - 'XPC_SERVICE_NAME': '0', 01:19:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:59 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-JeKYgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:59 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-lmxEtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:59 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-JyFT4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:59 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Xa82Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:59 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-nBAIrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:59 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)) 01:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:59 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-hltKfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-GvX1YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-YEI0dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-VlRYFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Zs8JyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-sktjGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-_07zoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-9tbHiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-DLW0Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-9NvfEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:20:00 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)) 01:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:20:00 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-8fxfg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:20:01 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)) 01:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:20:01 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-gWUues-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:20:01 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)) 01:20:01 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)) 01:20:01 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)) 01:20:01 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)) 01:20:01 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)) 01:20:01 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)) 01:20:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:03 INFO - Downloading blessings-1.6.tar.gz 01:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:20:03 INFO - Installing collected packages: blessings 01:20:03 INFO - Running setup.py install for blessings 01:20:03 INFO - Successfully installed blessings 01:20:03 INFO - Cleaning up... 01:20:04 INFO - Return code: 0 01:20:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:20:04 INFO - Reading from file tmpfile_stdout 01:20:04 INFO - Current package versions: 01:20:04 INFO - blessings == 1.6 01:20:04 INFO - blobuploader == 1.2.4 01:20:04 INFO - docopt == 0.6.1 01:20:04 INFO - functools32 == 3.2.3-2 01:20:04 INFO - jsonschema == 2.5.1 01:20:04 INFO - manifestparser == 1.1 01:20:04 INFO - mozInstall == 1.12 01:20:04 INFO - mozcrash == 0.17 01:20:04 INFO - mozdebug == 0.1 01:20:04 INFO - mozdevice == 0.48 01:20:04 INFO - mozfile == 1.2 01:20:04 INFO - mozhttpd == 0.7 01:20:04 INFO - mozinfo == 0.9 01:20:04 INFO - mozleak == 0.1 01:20:04 INFO - mozlog == 3.3 01:20:04 INFO - moznetwork == 0.27 01:20:04 INFO - mozprocess == 0.23 01:20:04 INFO - mozprofile == 0.28 01:20:04 INFO - mozrunner == 6.12 01:20:04 INFO - mozscreenshot == 0.1 01:20:04 INFO - mozsystemmonitor == 0.3 01:20:04 INFO - moztest == 0.7 01:20:04 INFO - mozversion == 1.4 01:20:04 INFO - psutil == 3.1.1 01:20:04 INFO - requests == 1.2.3 01:20:04 INFO - wsgiref == 0.1.2 01:20:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:20:04 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')]} 01:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:04 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')]} 01:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:04 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:20:04 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 01:20:04 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 01:20:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:20:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:20:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:20:04 INFO - 'HOME': '/Users/cltbld', 01:20:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:20:04 INFO - 'LOGNAME': 'cltbld', 01:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:04 INFO - 'MOZ_NO_REMOTE': '1', 01:20:04 INFO - 'NO_EM_RESTART': '1', 01:20:04 INFO - 'PAGER': '/bin/cat', 01:20:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:04 INFO - 'PWD': '/builds/slave/test', 01:20:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:20:04 INFO - 'SHELL': '/bin/bash', 01:20:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:20:04 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:20:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:20:04 INFO - 'USER': 'cltbld', 01:20:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:20:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:04 INFO - 'XPC_FLAGS': '0x0', 01:20:04 INFO - 'XPC_SERVICE_NAME': '0', 01:20:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 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)) 01:20:04 INFO - Cleaning up... 01:20:04 INFO - Return code: 0 01:20:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:20:04 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')]} 01:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:04 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')]} 01:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:04 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 0x104143a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0294c0200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, '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.5AljK5yn9w/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.RcnY60MImg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:20:04 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 01:20:04 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 01:20:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:20:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:20:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:20:04 INFO - 'HOME': '/Users/cltbld', 01:20:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:20:04 INFO - 'LOGNAME': 'cltbld', 01:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:04 INFO - 'MOZ_NO_REMOTE': '1', 01:20:04 INFO - 'NO_EM_RESTART': '1', 01:20:04 INFO - 'PAGER': '/bin/cat', 01:20:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:04 INFO - 'PWD': '/builds/slave/test', 01:20:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:20:04 INFO - 'SHELL': '/bin/bash', 01:20:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:20:04 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:20:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:20:04 INFO - 'USER': 'cltbld', 01:20:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:20:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:04 INFO - 'XPC_FLAGS': '0x0', 01:20:04 INFO - 'XPC_SERVICE_NAME': '0', 01:20:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:20:04 INFO - Cleaning up... 01:20:04 INFO - Return code: 0 01:20:04 INFO - Running post-action listener: _resource_record_post_action 01:20:04 INFO - Running post-action listener: _start_resource_monitoring 01:20:04 INFO - Starting resource monitoring. 01:20:04 INFO - [mozharness: 2016-08-08 08:20:04.830320Z] Finished create-virtualenv step (success) 01:20:04 INFO - [mozharness: 2016-08-08 08:20:04.831250Z] Running install step. 01:20:04 INFO - Running pre-action listener: _resource_record_pre_action 01:20:04 INFO - Running main action method: install 01:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:20:05 INFO - Reading from file tmpfile_stdout 01:20:05 INFO - Detecting whether we're running mozinstall >=1.0... 01:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:20:05 INFO - Reading from file tmpfile_stdout 01:20:05 INFO - Output received: 01:20:05 INFO - Usage: mozinstall [options] installer 01:20:05 INFO - Options: 01:20:05 INFO - -h, --help show this help message and exit 01:20:05 INFO - -d DEST, --destination=DEST 01:20:05 INFO - Directory to install application into. [default: 01:20:05 INFO - "/builds/slave/test"] 01:20:05 INFO - --app=APP Application being installed. [default: firefox] 01:20:05 INFO - mkdir: /builds/slave/test/build/application 01:20:05 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'] 01:20:05 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 01:20:39 INFO - Reading from file tmpfile_stdout 01:20:39 INFO - Output received: 01:20:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:20:39 INFO - Running post-action listener: _resource_record_post_action 01:20:39 INFO - [mozharness: 2016-08-08 08:20:39.504617Z] Finished install step (success) 01:20:39 INFO - [mozharness: 2016-08-08 08:20:39.504777Z] Running run-tests step. 01:20:39 INFO - Running pre-action listener: _resource_record_pre_action 01:20:39 INFO - Running main action method: run_tests 01:20:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:20:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:20:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:20:39 INFO - 2016-08-08 01:20:39.519 screenresolution[1644:7498] starting screenresolution argv=screenresolution get 01:20:39 INFO - 2016-08-08 01:20:39.521 screenresolution[1644:7498] Display 0: 1600x1200x32@60 01:20:39 INFO - 2016-08-08 01:20:39.527 screenresolution[1645:7500] starting screenresolution argv=screenresolution list 01:20:39 INFO - Available Modes on Display 0 01:20:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:20:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:20:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:20:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:20:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:20:39 INFO - Intel Iris: 01:20:39 INFO - Chipset Model: Intel Iris 01:20:39 INFO - Type: GPU 01:20:39 INFO - Bus: Built-In 01:20:39 INFO - VRAM (Dynamic, Max): 1536 MB 01:20:39 INFO - Vendor: Intel (0x8086) 01:20:39 INFO - Device ID: 0x0a2e 01:20:39 INFO - Revision ID: 0x0009 01:20:39 INFO - Displays: 01:20:39 INFO - Display: 01:20:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:20:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:20:39 INFO - Display Serial Number: 1600x1200 60 01:20:39 INFO - Main Display: Yes 01:20:39 INFO - Mirror: Off 01:20:39 INFO - Online: Yes 01:20:39 INFO - Rotation: Supported 01:20:39 INFO - Return code: 0 01:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:20:39 INFO - Python 2.7.3 01:20:39 INFO - Return code: 0 01:20:39 INFO - grabbing minidump binary from tooltool 01:20:39 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')]} 01:20:39 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 0x1040a7d30>, '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 0x103e0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10409fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:20:39 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 01:20:39 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 01:20:39 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 01:20:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:39 INFO - Return code: 0 01:20:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:20:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:20:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:20:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:20:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:20:39 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/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 01:20:39 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/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0381 --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 01:20:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AljK5yn9w/Render', 01:20:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:20:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:20:39 INFO - 'HOME': '/Users/cltbld', 01:20:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:20:39 INFO - 'LOGNAME': 'cltbld', 01:20:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:20:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:39 INFO - 'MOZ_NO_REMOTE': '1', 01:20:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:20:39 INFO - 'NO_EM_RESTART': '1', 01:20:39 INFO - 'PAGER': '/bin/cat', 01:20:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:20:39 INFO - 'PWD': '/builds/slave/test', 01:20:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:20:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:20:39 INFO - 'SHELL': '/bin/bash', 01:20:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcnY60MImg/Listeners', 01:20:39 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:20:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:20:39 INFO - 'USER': 'cltbld', 01:20:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:20:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:39 INFO - 'XPC_FLAGS': '0x0', 01:20:39 INFO - 'XPC_SERVICE_NAME': '0', 01:20:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:20:39 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/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 01:20:40 INFO - mozversion application_buildid: 20160807230447 01:20:40 INFO - mozversion application_changeset: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 01:20:40 INFO - mozversion application_display_name: Nightly 01:20:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:40 INFO - mozversion application_name: Firefox 01:20:40 INFO - mozversion application_remotingname: firefox 01:20:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:20:40 INFO - mozversion application_vendor: Mozilla 01:20:40 INFO - mozversion application_version: 51.0a1 01:20:40 INFO - mozversion platform_buildid: 20160807230447 01:20:40 INFO - mozversion platform_changeset: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 01:20:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:20:40 INFO - mozversion platform_version: 51.0a1 01:20:40 INFO - using testdate: 1470644440 01:20:40 INFO - actual date: 1470644440 01:20:40 INFO - starting webserver on 'localhost:49271' 01:20:40 INFO - SUITE-START | Running 2 tests 01:20:40 INFO - TEST-START | dromaeo_css 01:20:40 INFO - operating with platform_type : mac_ 01:20:40 INFO - Initialising browser for dromaeo_css test... 01:20:40 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpeZEMh1/profile http://localhost:49271/getInfo.html) 01:20:42 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 01:20:42 INFO - PROCESS | 1655 | colorDepth:24 01:20:42 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 01:20:42 INFO - PROCESS | 1655 | __metrics 01:20:42 INFO - PROCESS | 1655 | 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" 01:20:42 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:43 INFO - TEST-INFO | 1655: exit 0 01:20:43 INFO - Browser initialized. 01:20:43 INFO - Running cycle 1/1 for dromaeo_css test... 01:20:43 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpeZEMh1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:55 INFO - PROCESS | 1657 | RSS: Main: 243609600 01:20:55 INFO - PROCESS | 1657 | 01:21:46 INFO - PROCESS | 1657 | 1470644506386 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] 01:23:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 01:24:00 INFO - PROCESS | 1657 | RSS: Main: 358002688 01:24:00 INFO - PROCESS | 1657 | 01:27:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 01:27:04 INFO - PROCESS | 1657 | RSS: Main: 385982464 01:27:04 INFO - PROCESS | 1657 | 01:30:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 01:30:07 INFO - PROCESS | 1657 | RSS: Main: 353902592 01:30:07 INFO - PROCESS | 1657 | 01:33:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 01:33:10 INFO - PROCESS | 1657 | RSS: Main: 349786112 01:33:10 INFO - PROCESS | 1657 | 01:36:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 01:36:14 INFO - PROCESS | 1657 | RSS: Main: 347631616 01:36:14 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 01:39:17 INFO - PROCESS | 1657 | RSS: Main: 593170432 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | __start_tp_report 01:39:17 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 01:39:17 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 01:39:17 INFO - PROCESS | 1657 | |i|pagename|runs| 01:39:17 INFO - PROCESS | 1657 | |0;dojo.html;3320;3326.1850846542584;3327.1016825457127;3351.983240083799;3419.726421886248;5518.91721624176;5557.7776888924445;5621.437856214377;5627.606067575277;5665.5467562594995;5409.702466364358;5502.0921547944645;5526.696031718254;5548.611597188198;5619.80330688427;5090.287359769617;5139.229115632666;5156.53591176794;5162.1224391853475;5270.9736451317685;5262.394824595163;5269.736513174345;5271.341082364705;5272.156454967206;5274.367075950891;4846.176150054499;4867.123917694814;4890.462049174588;5179.119549676564;5255.921161182585;4885.5358740919555;4897.4123105227245;4898.510148985109;4905.068037072981;4913.336699545587;5079.161938280216;5136.8698886244965;5163.922541161885;5210.192420174879;5230.581553475713;5406;5469.453054694539;5473.616846820724;5502.642328248651;5539.390667026624;5853.50245229156;5876.353601103875;5934;5938.168656388109;5938.435848594377;6000.249968753906;6086.087086936995;6132.938670613281;6145.754169833202;6146.217596896895;5726.79956201531;5776.277965254343;5794.536437085023;5800.419958004166;5810.302763668386;5830.950428922834;6055.005762886994;6381.744730210832;6387.552871299057;6402.391772781578;5920.171176035358;6004.669743164168;6112.480439162632;6122.112293717386;6131.816045518642;6116.914073580098;6172.197614310111;6196.566240363221;6247.781327653511;6261.24865016201;6086.847828804315;6156.168917196211;6160.1375807387;6185.072239164071;6191.411815877575;5989.9101513477335;6117.847053823601;6207.068939659087;6216.44052035319;6222.222222222223;4851.878703032452;4857.441394239708;4886.657933944661;4913.213885778258;4913.533214344631;4408.735475871394;4412.271975124133;4417.204903117469;4435.667324950641;4464.53122422141;5666.575006874501;5688.744006519716;5694.117411801178;5702.800401985911;5721.199032135504;6089.604175728564;6153.538484613672;6182;6270.31026587075;6303.275123360872;5706.429357064343;5709.714514274269;5730.111832665943;5733.541316694655;5736.340320863154;5179.015986962465;5184.533391994739;5192.688438693691;5201.531862132426;5202.3497062867145;6185.536084793658;6186.907196392148;6199.969000155151;6231.594946328474;6251.062340648939;6164.044573091178;6244.718987645476;6250.624962502265;6311;6319.747210111544;6308;6353.650549219838;6363.459105976044;6381;6387.936120638734;5903.498202652822;6169.074638804036;6176.938230617816;6178.073289006685;6191.969040154951;6120.2947619997085;6174.012158054869;6179.227596550431;6264.123022776906;6284.591501552384;5929.52563794904;6038.667873266837;6065.363136870742;6072.878542429038;6084.969575152096;5811.970940145441;6063.757449702139;6063.909041364295;6070.1198326241565;6084.209052823105;5827.8834423310445;5894.675792831264;5918.704064796829;5991.550633702577;5991.760329586942;6018.909716354171;6028.577999540165;6078.756849725962;6085.361037091042;6087.969560152171;5719.142128680731;5800.9419905800405;5891.05743081105;5907.438793314628;5920.319163296103 01:39:17 INFO - PROCESS | 1657 | |1;ext.html;481.27223268466213;499.8353835563134;509.9266044975327;522.9827984570011;542.0270614247426;30428.391432171342;39816.00459988502;41142.38286425706;41142.58857411425;43231.351529727;42388.364174537404;42757.358639620354;42794.71615851529;42875.78562107185;42983;8664.8700269496;9601.663941762057;9825.361351512165;9825.410475371466;9826.213902887788;8662.177093176138;11483.13876459269;11734.647960561197;11737.94131029348;12064.396780161002;11801.232919860224;11859.229150105259;11865.110116741278;11865.7626847463;11873.287602743863;11649.825252621218;11695.35675537845;11713.53145874164;11714.297142171412;11718.53125874964;11585.246958947642;11683.591074312444;11688.240264382788;11694.356810375426;11728.237664551862;39769.20461590781;39944.400833987514;40073.59926400757;40094.39858402126;40142.99642508961;3388.8305584720665;3548.8935331940083;3606.765560238576;3870.748401353931;3900.824462899148;31154.909578164883;32007.51988720171;32266.516002259985;32319.6768032319;32328.838355808304;3262.1029216965285;3346.4143774839304;3347.8995630131135;3379.9662003380145;3383.661633836621;512197;512338;513407;513979;514367;58522.70738646365;58672;58706.706466467396;58812.7059364709;58896.705516472146;61711.6914415434;61839.6908015457;61954.69022654858;62046;62091.689541552005;14586.270686465634;16072.9552579082;16324.591885202964;16354.672906541802;16356.100414477318;11454.713632159095;11706.239094458833;11709.531618735326;11776.587819426279;11936.403179841147;15323.923380383027;15973.520794375954;16049.95675281103;16057.839421605868;16127;4903.482031043463;6277.7175027123885;6300.1494798202575;6336.746530138835;6361.9045714314325;905.2576886952767;965.165132160676;991.3258983891023;996.7059717383389;1070.3203465799274;29178.854105729337;29424.852875735483;29593.852030740138;29802.701972980427;29906.401871962873;1096.4408151842617;1131.3890499130541;1144.13046084976;1163.9989608936307;1227;14764.704705906037;15374.615634609001;15449.691006179813;15494.922525387301;15780.13209273478;617874;686656;692164;692366;693066;58281;58712;58844.41155588475;58935;59430.10854837181;1235.3452670084869;1294.5922034559271;1370.7327071221414;1386.5840247925785;1406.585057408067;24324.513509729353;25615.743842561336;31062.534061988637;31562.36875262436;31768.841155795;54975;56704;57042.7147864258;59509;59577;504957;507220;508098;509060;509296;26058.957641694877;26187.607185891844;26648.46703065889;26770.866145669148;26976;47394;47642;47769.56691299267;48204;48526.786830329525;38979;39065.60934390734;39172.41241381439;40728.59271407248;40757.38863916984;38839.61160388473;38953.610463895;39148.80425597854;39900.2019959605;40430.595694042684;38328.80835595804;38742.6125738739;38899.61100389073;38967.80516097515;38992.41511377388;33738.156546086546;34028.97913062612;34874.9537513875;34926.12684682903;35096;24332;24853.25440236796;25165.993360265384;25567;25839.70801459957 01:39:17 INFO - PROCESS | 1657 | |2;jquery.html;348.09148123397944;368.0761289164197;368.3369934118586;373.2795704290719;395.93269144245477;16092.51722448327;16641.750373744388;20605.175792968264;20611.175552977864;20749.066292016858;20953.476163095893;20961.790382096173;21570.676439853414;21590.89204553979;21744.238951636697;6532.902006469907;6588.407043366096;6718.49611279156;6815.250322464525;6877.174739031323;6672.699728512229;6727.125473688414;6773.661316934158;6774.898376524356;6795;4406.272964960777;5823.737931793058;7681.155072941972;7684.462087653867;7754.340881025119;7563.357114645261;7622.390208783339;7701.0758708955;7750;7788.649510772028;7486.251374862524;7526.134494533144;7535.886961695579;7535.9246407535775;7539.623018849091;25846;26040.34899127537;26562.33594160142;29593.11220663362;30183.245418864484;2383.785459308653;2454.361865914857;2626.566616508274;2983.74638155757;3174.0319202643186;17012.31950721982;17071.061091639956;17072.914635426743;17656.735148972777;17673.204705788143;1880.6520793653217;1902.1345287893976;1923.778765441978;1980.772211195702;2091.581683663258;101918;108039;132033.6796632031;150853.9999999989;150995.49004510033;18079.276828926697;19333.61332773337;21084;22078.33764987053;22382.530707740327;36741;36830.63169368326;36852;36928.81535592359;36955.63044369522;9184.357095003286;10845.511951962022;10849.349039057683;11067;11110.500027498781;8984.595693193822;9016.8647470288;9024.8646270306;9225.308101892386;9242.86135707965;9525.14273715355;9918.454485003394;9943.502824858728;9987.900120998842;10027.197824174049;3644.799536025544;3742.288965096623;3746.269477451871;3755.962440375561;3758.473813666089;723.2080871445759;761.7745205202477;838.2372041442259;867.5532100968006;937.6108914800418;21739.80431076306;22150;22185.44536386603;22188.00153993074;22188.667169992463;860.7159637319669;911.1571796088591;911.9193755399872;951.2152474208806;966.5650457294246;11069.612563560237;11484.712882178012;11492.080633549296;11581.76836463266;11586.652400428;510998;519841;521610;618475;624016;133963;134444.32777836244;141292.29353853164;141895;146356.53643463642;964.9131578158;993.1558175550869;1021.6934919524261;1024.7643042100358;1027.5632856036154;15490.612734681272;18388.632227355647;19849.610527263532;20577.176912923915;20672.89663551733;37945.48218071246;42358.57641423546;47439.81400465016;58173.4182658168;61330.77338453295;75877.62061189879;77585;80724.59637701773;81456;82847;7032.613206273704;7039.331263529956;7391.556506609621;8205.425620206766;8461.915380846112;12041;12914.22514649124;12934.353282335658;13439.865601344252;13525.797113043509;11078.833817492905;11176.329420234812;11554.306741595195;11612.361320127475;11700;9489.240860730986;10893.07408870255;10951.671449856518;11594.188406811441;11643;11414.258073225214;11511.19421640477;11738.70653233676;11870.703232419259;11923.582674606347;8109.918900810916;8219.342452603658;8293.21214484623;8319.542425166674;8391.916080839357;8457.746267611981;11136.888631113909;11332;11582.826257606312;11680.883191167979 01:39:17 INFO - PROCESS | 1657 | |3;mootools.html;1460.1093333066826;1511.954641360759;1700.302875820913;1831.8259765322289;1899.591587808621;8251.133630968752;8797.824043519126;8810.735677929664;8814.60334284957;8814.735557933273;7747.767566973;7973.60131993401;8338.958305208465;8563.058063612998;8589.398742088057;2308.3651995701234;2332.9066837326486;2337.614293641556;2341.4497593065616;2346.2609278077352;2006.8695534790265;2258.627326491127;2291.1179196009575;2295.116380193621;2314.1900334882826;2322.1872344679314;2333.7666233376694;2343.4610039690883;2351.071326825903;2354.470244195051;2321.1527792355755;2335.1593426366494;2338.0297176671747;2340.157543284416;2345.683332750091;2310.722713274401;2310.803581695558;2310.8960096795686;2316.698829152216;2318.362450326157;8679.392442529026;8710.782230444227;8793.164649358301;8796.120387961153;8816.20654141124;5083.822066227701;5259.0270799901755;5262.105442074857;5265.052290587692;5266.7629956652045;3385.407553678121;3444.689977902001;3573.982130089359;3595;3595.6404359564094;1082.734729991157;1102.399192440122;1772.459399883035;1827.7898041725239;1870.186468886039;11441.313521188673;11502.424878756112;11522.769544609144;11539.942300288445;11541.019013383873;4120.484939382577;4328.696991210585;4380.978095109568;4387.561243875651;4405.581469760367;8997.685081022133;9006.774830629287;9016.684416045407;9027.819443611092;9033.457992520338;4986.152354099811;4987.825426110141;4993.251012348177;4993.500649934977;5003.924941125886;4097.262492751273;4334.956650433518;4480.910381792346;4650.162970665313;4842.346283251786;3685.539307586552;3714.23858109087;3811.7141214408475;3818.7326887117633;3837.194189220295;991.2961797123978;991.8561808537866;1123.971900702489;1145.604766355606;1159.1538177130742;782.22950393862;877.2455688108349;899.5457294066455;908.42315129893;952.3048174832411;5808.680522571299;5998.3701711320555;6005.519558435315;6057.363976782374;6100.572959892765;925.8611208318806;963.1812958984807;966.3911735606663;979.3634137810337;1014.2038499777639;3957.782321972262;3971.146203566247;3981.044549308145;4032.737872038308;4140.958590414058;10342.482875856178;10761.30051546647;10762.946185269024;10763.946180269206;10776.245662803529;10030.74923126913;10474.37153770761;10481.580736770597;10680.198985075995;10755.731106722395;7244.311790379906;7971.920280797234;7978.920210797818;8178.959105204555;8186.754397368089;5983.730732117152;5990.820275391745;6092.75628974836;6153.13856060143;6173.104899789595;9725.416475011521;10058.899411005796;10097.444640544547;10111.191104711459;10117.949410252902;9300.953495232481;9576.904230957602;9687.370320929118;10240.436775977392;10351.534180961724;7270.636468176464;7588.392928565812;7592.620368981639;7666.9616651916385;7715.421343399155;7951.721689740832;8189.918100818915;8270.669173233004;8409.411341206056;8415.200555947175;7306.561606303639;7367.1527774304495;7419.22098179705;7445.441591880739;7503.512271702322;7225.891611625935;7242.348188663045;7248.601326926859;7256.1655409628565;7294.96352518234;6635.104260924713;6852.246252912275;6930.064441300561;6968.233494315723;7005.194402643761;4797.8080876765935;4833.613310935187;4835.758212089452;4953.504649535018;4965.3296804932315;4982.501749824988;5068.543831055223;5092.872678183075;5142.228665700175;5231.529162375405 01:39:17 INFO - PROCESS | 1657 | |4;prototype.html;300.66626045089953;310.71724730495254;312.65763988432667;317.50944790298973;320.08455816365176;5328.280682107919;5330;5382.811601593945;5393.191021346795;5426.430224826396;4907.282451142099;4913.705177689332;5162.5611822995;5385.0037743017565;5403.918941215875;3871.961280387195;3922.41163825427;4028.6777057835448;4074.2258970795456;4156.231097247004;3381.0871064812486;4018.377151541501;4060.979695101535;4106.691998100139;4118.732282401649;3999.6200360965663;4007.7996100194873;4039.474868267121;4058.7970601469956;4100.118474527976;3796.4055096859383;3800.391937290048;3995.40068989651;4065.999999999985;4077.6145954616586;2912.66504351998;3226.709596136359;3472.808995505246;3477.739169562293;3494.8951531454095;4969.82605608802;5202.401723801773;5239.816606418795;5247.932852039662;5268.236105764681;3893.364786789555;4234.470691163605;4596.908061838744;4619.584237418615;4642.605378542794;5531.834044978657;5554.3614633682755;5580.944190558123;5591.4688104629995;5620.381758006616;3774.830132644038;3779.7354185207046;3789.4315852622053;3809.3904975204114;3826.234753049401;5650.830475085754;5788.797392091299;5900.468957793819;5933.525317974551;5941.851453713649;3270.149761062141;3356.009977056774;3854.479645247912;3871.8064096795047;3899.805009749501;3586.677199052098;3726.925461490809;3948.368261078214;3964.345882929342;3967.5238971323624;4103.707332190351;4529.886752831206;4537.795799189044;4555.931661025087;4558.407407037064;4606.723596584216;4950;5129.640085743844;5669.744861481161;5725.198472213893;1323.9801402978962;1344.213635023522;1349.9055066145472;1350.8176396186586;1351.4526616720243;680.6285335049879;804.8691588318422;819.1439945257221;820.7906983719114;835.8913341265718;4377.781110944504;5122.334096567422;5140.511651393112;5294.682319060792;5303.090887280576;5713.914291285634;5746.856328591735;5754.539636829044;5799.3620701722775;5806.593538452268;4944.456109827916;5252.474752524717;5264.341957255343;5265.894682106413;5303.946960530346;2405.6888995497497;2968.2727731705872;2998.565208044865;3047.506721706348;3052.2979714665753;5063.468335824759;5975.7609695612555;5993.820185394445;6023.759049638053;6032.728527216286;5223.022876960096;5462.962037212917;5531.778728850882;5733.799317023884;5946.07835785454;5055.772490237875;5911.103559256019;5985.456181123005;6001.279846418458;6014.789482368096;5459.645123066988;5642.238297829905;5773.3072031356505;5776.566757493289;5801.186424584158;5169.586433085269;5456;5651.378348381592;5753.769849205984;5779.393163717918;5933.703314834327;5985.311689155803;5997.880042399041;5999.240349439307;6013.632365875124;2704.878280477344;3288.556044933903;3567.8751243706347;3825.196708691206;3897;5766.538676905921;5768.529025098741;5771.336296325809;5780.508656764222;5804.533073443854;5615.915761263666;5655.321361436654;5663.348714897675;5665.753534222465;5673.347565030074;4712;5427.972860135674;5656.830295091154;5667.971660141673;5671.319441667027;4432;4735.697683137165;4786.473487916396;5560.110382338807;5571.498565129158;4718.834840780556;4960.826371076995;5498.477644623755;5651.971740141273;5726.656400615976;4169.728232888998;5011.271111466538;5512.80705175317;5586.86032849182;5595.88082383533 01:39:17 INFO - PROCESS | 1657 | |5;yui.html;637.8773358888355;723.464636169235;728.1844334345532;766.4711349169073;823.5388182617733;15624.687506249882;16617.91691041546;16631.33474661015;16657.167141642916;16682.916585417057;14846.703065938702;14987.47543835966;15025.774613380809;15036;15092.622684432894;677.8068250548595;710.6162672157029;843.4222557548069;860.6557377049184;882.0561998661435;870.8693695945595;882.4528792148876;882.9072947340533;886.8891388576428;890.3411475508142;945.8486642137259;946.2713710442955;947.9194268487187;950.980980380392;951.6954574536152;940.9952950235239;944.9716508504756;945.1399226703667;945.6312038305067;947.4504787223428;515.914874045782;658.8912829383194;691.3225039461356;692.5013989927244;694.3577191098213;15014.699706005818;15018.924905375403;15063;15081.698366032619;15108;13896.861031389657;14331.856681433157;14437.35031923566;14471.348789304506;14544.2000689962;13049.608511744664;13182.34088295591;13210.735785284336;13456.192628442226;13814.447422103103;4583;4760.738159401231;4785.593224575915;4803.111424386465;4842.806287748486;113542;114155.42922285336;120362.39818800938;123323;124739.12891306728;10978.725531861608;11451.427428628534;11609.3614851184;11739.178257521891;11848.585299514649;22628.208012719806;23083.653745193835;23129.884350578475;23134;23141.884290578775;5996.850078747979;7929.212705462952;7986.720464783704;7988.920110798817;8202.179782021869;4371.453568303962;4416.1609294233995;4482.618977386958;4497.505274419811;4633.606143477775;3504.0539054455153;3609.224016836393;3625.728070394731;3633.0372451300427;3654.6528079832906;547.5947798629065;637.4135795068455;654.499308029358;664.1764212376714;666.9166354205724;593.2228780297824;609.823151286131;625.5339771869986;640.2285246278224;650.5186162239909;8906.465612063297;9090.454822558235;9256.7685807854;9444.197243234265;9518.47648379332;596.2517041113375;601.4196300569971;629.3454807000668;631.2059905021356;639.7409049335026;4410.140022695544;4438.467383913951;4446.955530444654;4491.108758010075;4609.3086037094035;118407;121525.35423937296;121530;124824;127713.36143319224;88928;110156.4492177534;111783.88216117898;113912;116248.41875790736;100130;100592;107325.46337268264;108069.4596527028;110123;8658.696945606873;8842.248408885316;10096.444695541815;10110.8483372748;10131.189504839742;58081.4191858076;58273.66905323909;58614.70692646509;58749.831267717986;59776.701116494136;87028;89350.55324723334;93338;93560.06439935513;95204;12627.3686315682;13129.277889715775;13193.14244574138;13213.339333033118;13914.860851391357;14887.255637218312;14957.40170393172;14967.32647030908;15085.47200847965;15783.842161578237;13801.861981380058;13808.654783630489;14239.572812815632;14434;14502.564923052325;14139.575812725634;14159.008869379044;14318.284085795876;14366.928165359524;14738.484153054591;13721.313934303445;13736.386304262565;13867.11636423509;13892.305384730926;14316.06945548536;11108.222424430536;11283.943580282046;11681.06551475897;11866.82199766987;11916.523339066687;10003.849942250727;10385;11263.127902385168;11603.593874214363;11634.476448559666 01:39:17 INFO - PROCESS | 1657 | __end_tp_report 01:39:17 INFO - PROCESS | 1657 | __start_cc_report 01:39:17 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1273 01:39:17 INFO - PROCESS | 1657 | __end_cc_report 01:39:17 INFO - PROCESS | 1657 | __startTimestamp1470645557848__endTimestamp 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | ------- Summary: start ------- 01:39:17 INFO - PROCESS | 1657 | Number of tests: 6 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5672.36 Median:5891.06 stddev:643.03 (10.9%) stddev-sans-first:617.95 01:39:17 INFO - PROCESS | 1657 | Values: 3320.0 3326.2 3327.1 3352.0 3419.7 5518.9 5557.8 5621.4 5627.6 5665.5 5409.7 5502.1 5526.7 5548.6 5619.8 5090.3 5139.2 5156.5 5162.1 5271.0 5262.4 5269.7 5271.3 5272.2 5274.4 4846.2 4867.1 4890.5 5179.1 5255.9 4885.5 4897.4 4898.5 4905.1 4913.3 5079.2 5136.9 5163.9 5210.2 5230.6 5406.0 5469.5 5473.6 5502.6 5539.4 5853.5 5876.4 5934.0 5938.2 5938.4 6000.2 6086.1 6132.9 6145.8 6146.2 5726.8 5776.3 5794.5 5800.4 5810.3 5831.0 6055.0 6381.7 6387.6 6402.4 5920.2 6004.7 6112.5 6122.1 6131.8 6116.9 6172.2 6196.6 6247.8 6261.2 6086.8 6156.2 6160.1 6185.1 6191.4 5989.9 6117.8 6207.1 6216.4 6222.2 4851.9 4857.4 4886.7 4913.2 4913.5 4408.7 4412.3 4417.2 4435.7 4464.5 5666.6 5688.7 5694.1 5702.8 5721.2 6089.6 6153.5 6182.0 6270.3 6303.3 5706.4 5709.7 5730.1 5733.5 5736.3 5179.0 5184.5 5192.7 5201.5 5202.3 6185.5 6186.9 6200.0 6231.6 6251.1 6164.0 6244.7 6250.6 6311.0 6319.7 6308.0 6353.7 6363.5 6381.0 6387.9 5903.5 6169.1 6176.9 6178.1 6192.0 6120.3 6174.0 6179.2 6264.1 6284.6 5929.5 6038.7 6065.4 6072.9 6085.0 5812.0 6063.8 6063.9 6070.1 6084.2 5827.9 5894.7 5918.7 5991.6 5991.8 6018.9 6028.6 6078.8 6085.4 6088.0 5719.1 5800.9 5891.1 5907.4 5920.3 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:70300.63 Median:21306.68 stddev:152680.85 (716.6%) stddev-sans-first:153019.17 01:39:17 INFO - PROCESS | 1657 | Values: 481.3 499.8 509.9 523.0 542.0 30428.4 39816.0 41142.4 41142.6 43231.4 42388.4 42757.4 42794.7 42875.8 42983.0 8664.9 9601.7 9825.4 9825.4 9826.2 8662.2 11483.1 11734.6 11737.9 12064.4 11801.2 11859.2 11865.1 11865.8 11873.3 11649.8 11695.4 11713.5 11714.3 11718.5 11585.2 11683.6 11688.2 11694.4 11728.2 39769.2 39944.4 40073.6 40094.4 40143.0 3388.8 3548.9 3606.8 3870.7 3900.8 31154.9 32007.5 32266.5 32319.7 32328.8 3262.1 3346.4 3347.9 3380.0 3383.7 512197.0 512338.0 513407.0 513979.0 514367.0 58522.7 58672.0 58706.7 58812.7 58896.7 61711.7 61839.7 61954.7 62046.0 62091.7 14586.3 16073.0 16324.6 16354.7 16356.1 11454.7 11706.2 11709.5 11776.6 11936.4 15323.9 15973.5 16050.0 16057.8 16127.0 4903.5 6277.7 6300.1 6336.7 6361.9 905.3 965.2 991.3 996.7 1070.3 29178.9 29424.9 29593.9 29802.7 29906.4 1096.4 1131.4 1144.1 1164.0 1227.0 14764.7 15374.6 15449.7 15494.9 15780.1 617874.0 686656.0 692164.0 692366.0 693066.0 58281.0 58712.0 58844.4 58935.0 59430.1 1235.3 1294.6 1370.7 1386.6 1406.6 24324.5 25615.7 31062.5 31562.4 31768.8 54975.0 56704.0 57042.7 59509.0 59577.0 504957.0 507220.0 508098.0 509060.0 509296.0 26059.0 26187.6 26648.5 26770.9 26976.0 47394.0 47642.0 47769.6 48204.0 48526.8 38979.0 39065.6 39172.4 40728.6 40757.4 38839.6 38953.6 39148.8 39900.2 40430.6 38328.8 38742.6 38899.6 38967.8 38992.4 33738.2 34029.0 34875.0 34926.1 35096.0 24332.0 24853.3 25166.0 25567.0 25839.7 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:36164.27 Median:1761.06 stddev:94457.90 (5363.7%) stddev-sans-first:94684.60 01:39:17 INFO - PROCESS | 1657 | Values: 348.1 368.1 368.3 373.3 395.9 16092.5 16641.8 20605.2 20611.2 20749.1 20953.5 20961.8 21570.7 21590.9 21744.2 6532.9 6588.4 6718.5 6815.3 6877.2 6672.7 6727.1 6773.7 6774.9 6795.0 4406.3 5823.7 7681.2 7684.5 7754.3 7563.4 7622.4 7701.1 7750.0 7788.6 7486.3 7526.1 7535.9 7535.9 7539.6 25846.0 26040.3 26562.3 29593.1 30183.2 2383.8 2454.4 2626.6 2983.7 3174.0 17012.3 17071.1 17072.9 17656.7 17673.2 1880.7 1902.1 1923.8 1980.8 2091.6 101918.0 108039.0 132033.7 150854.0 150995.5 18079.3 19333.6 21084.0 22078.3 22382.5 36741.0 36830.6 36852.0 36928.8 36955.6 9184.4 10845.5 10849.3 11067.0 11110.5 8984.6 9016.9 9024.9 9225.3 9242.9 9525.1 9918.5 9943.5 9987.9 10027.2 3644.8 3742.3 3746.3 3756.0 3758.5 723.2 761.8 838.2 867.6 937.6 21739.8 22150.0 22185.4 22188.0 22188.7 860.7 911.2 911.9 951.2 966.6 11069.6 11484.7 11492.1 11581.8 11586.7 510998.0 519841.0 521610.0 618475.0 624016.0 133963.0 134444.3 141292.3 141895.0 146356.5 964.9 993.2 1021.7 1024.8 1027.6 15490.6 18388.6 19849.6 20577.2 20672.9 37945.5 42358.6 47439.8 58173.4 61330.8 75877.6 77585.0 80724.6 81456.0 82847.0 7032.6 7039.3 7391.6 8205.4 8461.9 12041.0 12914.2 12934.4 13439.9 13525.8 11078.8 11176.3 11554.3 11612.4 11700.0 9489.2 10893.1 10951.7 11594.2 11643.0 11414.3 11511.2 11738.7 11870.7 11923.6 8109.9 8219.3 8293.2 8319.5 8391.9 8457.7 11136.9 11332.0 11582.8 11680.9 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5627.93 Median:4984.33 stddev:3126.17 (62.7%) stddev-sans-first:3119.25 01:39:17 INFO - PROCESS | 1657 | Values: 1460.1 1512.0 1700.3 1831.8 1899.6 8251.1 8797.8 8810.7 8814.6 8814.7 7747.8 7973.6 8339.0 8563.1 8589.4 2308.4 2332.9 2337.6 2341.4 2346.3 2006.9 2258.6 2291.1 2295.1 2314.2 2322.2 2333.8 2343.5 2351.1 2354.5 2321.2 2335.2 2338.0 2340.2 2345.7 2310.7 2310.8 2310.9 2316.7 2318.4 8679.4 8710.8 8793.2 8796.1 8816.2 5083.8 5259.0 5262.1 5265.1 5266.8 3385.4 3444.7 3574.0 3595.0 3595.6 1082.7 1102.4 1772.5 1827.8 1870.2 11441.3 11502.4 11522.8 11539.9 11541.0 4120.5 4328.7 4381.0 4387.6 4405.6 8997.7 9006.8 9016.7 9027.8 9033.5 4986.2 4987.8 4993.3 4993.5 5003.9 4097.3 4335.0 4480.9 4650.2 4842.3 3685.5 3714.2 3811.7 3818.7 3837.2 991.3 991.9 1124.0 1145.6 1159.2 782.2 877.2 899.5 908.4 952.3 5808.7 5998.4 6005.5 6057.4 6100.6 925.9 963.2 966.4 979.4 1014.2 3957.8 3971.1 3981.0 4032.7 4141.0 10342.5 10761.3 10762.9 10763.9 10776.2 10030.7 10474.4 10481.6 10680.2 10755.7 7244.3 7971.9 7978.9 8179.0 8186.8 5983.7 5990.8 6092.8 6153.1 6173.1 9725.4 10058.9 10097.4 10111.2 10117.9 9301.0 9576.9 9687.4 10240.4 10351.5 7270.6 7588.4 7592.6 7667.0 7715.4 7951.7 8189.9 8270.7 8409.4 8415.2 7306.6 7367.2 7419.2 7445.4 7503.5 7225.9 7242.3 7248.6 7256.2 7295.0 6635.1 6852.2 6930.1 6968.2 7005.2 4797.8 4833.6 4835.8 4953.5 4965.3 4982.5 5068.5 5092.9 5142.2 5231.5 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4537.56 Median:5166.07 stddev:1430.97 (27.7%) stddev-sans-first:1399.20 01:39:17 INFO - PROCESS | 1657 | Values: 300.7 310.7 312.7 317.5 320.1 5328.3 5330.0 5382.8 5393.2 5426.4 4907.3 4913.7 5162.6 5385.0 5403.9 3872.0 3922.4 4028.7 4074.2 4156.2 3381.1 4018.4 4061.0 4106.7 4118.7 3999.6 4007.8 4039.5 4058.8 4100.1 3796.4 3800.4 3995.4 4066.0 4077.6 2912.7 3226.7 3472.8 3477.7 3494.9 4969.8 5202.4 5239.8 5247.9 5268.2 3893.4 4234.5 4596.9 4619.6 4642.6 5531.8 5554.4 5580.9 5591.5 5620.4 3774.8 3779.7 3789.4 3809.4 3826.2 5650.8 5788.8 5900.5 5933.5 5941.9 3270.1 3356.0 3854.5 3871.8 3899.8 3586.7 3726.9 3948.4 3964.3 3967.5 4103.7 4529.9 4537.8 4555.9 4558.4 4606.7 4950.0 5129.6 5669.7 5725.2 1324.0 1344.2 1349.9 1350.8 1351.5 680.6 804.9 819.1 820.8 835.9 4377.8 5122.3 5140.5 5294.7 5303.1 5713.9 5746.9 5754.5 5799.4 5806.6 4944.5 5252.5 5264.3 5265.9 5303.9 2405.7 2968.3 2998.6 3047.5 3052.3 5063.5 5975.8 5993.8 6023.8 6032.7 5223.0 5463.0 5531.8 5733.8 5946.1 5055.8 5911.1 5985.5 6001.3 6014.8 5459.6 5642.2 5773.3 5776.6 5801.2 5169.6 5456.0 5651.4 5753.8 5779.4 5933.7 5985.3 5997.9 5999.2 6013.6 2704.9 3288.6 3567.9 3825.2 3897.0 5766.5 5768.5 5771.3 5780.5 5804.5 5615.9 5655.3 5663.3 5665.8 5673.3 4712.0 5428.0 5656.8 5668.0 5671.3 4432.0 4735.7 4786.5 5560.1 5571.5 4718.8 4960.8 5498.5 5652.0 5726.7 4169.7 5011.3 5512.8 5586.9 5595.9 01:39:17 INFO - PROCESS | 1657 | 01:39:17 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:23847.10 Median:23137.94 stddev:36218.20 (156.5%) stddev-sans-first:36277.88 01:39:17 INFO - PROCESS | 1657 | Values: 637.9 723.5 728.2 766.5 823.5 15624.7 16617.9 16631.3 16657.2 16682.9 14846.7 14987.5 15025.8 15036.0 15092.6 677.8 710.6 843.4 860.7 882.1 870.9 882.5 882.9 886.9 890.3 945.8 946.3 947.9 951.0 951.7 941.0 945.0 945.1 945.6 947.5 515.9 658.9 691.3 692.5 694.4 15014.7 15018.9 15063.0 15081.7 15108.0 13896.9 14331.9 14437.4 14471.3 14544.2 13049.6 13182.3 13210.7 13456.2 13814.4 4583.0 4760.7 4785.6 4803.1 4842.8 113542.0 114155.4 120362.4 123323.0 124739.1 10978.7 11451.4 11609.4 11739.2 11848.6 22628.2 23083.7 23129.9 23134.0 23141.9 5996.9 7929.2 7986.7 7988.9 8202.2 4371.5 4416.2 4482.6 4497.5 4633.6 3504.1 3609.2 3625.7 3633.0 3654.7 547.6 637.4 654.5 664.2 666.9 593.2 609.8 625.5 640.2 650.5 8906.5 9090.5 9256.8 9444.2 9518.5 596.3 601.4 629.3 631.2 639.7 4410.1 4438.5 4447.0 4491.1 4609.3 118407.0 121525.4 121530.0 124824.0 127713.4 88928.0 110156.4 111783.9 113912.0 116248.4 100130.0 100592.0 107325.5 108069.5 110123.0 8658.7 8842.2 10096.4 10110.8 10131.2 58081.4 58273.7 58614.7 58749.8 59776.7 87028.0 89350.6 93338.0 93560.1 95204.0 12627.4 13129.3 13193.1 13213.3 13914.9 14887.3 14957.4 14967.3 15085.5 15783.8 13801.9 13808.7 14239.6 14434.0 14502.6 14139.6 14159.0 14318.3 14366.9 14738.5 13721.3 13736.4 13867.1 13892.3 14316.1 11108.2 11283.9 11681.1 11866.8 11916.5 10003.8 10385.0 11263.1 11603.6 11634.5 01:39:17 INFO - PROCESS | 1657 | -------- Summary: end -------- 01:39:17 INFO - PROCESS | 1657 | 01:39:18 INFO - TEST-INFO | 1657: exit 0 01:39:18 INFO - TEST-OK | dromaeo_css | took 1118380ms 01:39:18 INFO - TEST-START | kraken 01:39:18 INFO - operating with platform_type : mac_ 01:39:18 INFO - Initialising browser for kraken test... 01:39:18 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpBlLQL_/profile http://localhost:49271/getInfo.html) 01:39:20 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 01:39:20 INFO - PROCESS | 1667 | colorDepth:24 01:39:20 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 01:39:20 INFO - PROCESS | 1667 | __metrics 01:39:21 INFO - PROCESS | 1667 | 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" 01:39:21 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:39:21 INFO - TEST-INFO | 1667: exit 0 01:39:21 INFO - Browser initialized. 01:39:21 INFO - Running cycle 1/1 for kraken test... 01:39:21 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpBlLQL_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:33 INFO - PROCESS | 1668 | RSS: Main: 243601408 01:39:33 INFO - PROCESS | 1668 | 01:39:36 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 01:39:37 INFO - PROCESS | 1668 | RSS: Main: 294363136 01:39:37 INFO - PROCESS | 1668 | 01:39:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 01:39:40 INFO - PROCESS | 1668 | RSS: Main: 301101056 01:39:40 INFO - PROCESS | 1668 | 01:39:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 01:39:44 INFO - PROCESS | 1668 | RSS: Main: 396480512 01:39:44 INFO - PROCESS | 1668 | 01:39:46 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 01:39:47 INFO - PROCESS | 1668 | RSS: Main: 296558592 01:39:47 INFO - PROCESS | 1668 | 01:39:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:39:49 INFO - PROCESS | 1668 | RSS: Main: 301789184 01:39:49 INFO - PROCESS | 1668 | 01:39:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 01:39:53 INFO - PROCESS | 1668 | RSS: Main: 340643840 01:39:53 INFO - PROCESS | 1668 | 01:39:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 01:39:56 INFO - PROCESS | 1668 | RSS: Main: 340484096 01:39:56 INFO - PROCESS | 1668 | 01:39:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 01:40:00 INFO - PROCESS | 1668 | RSS: Main: 339103744 01:40:00 INFO - PROCESS | 1668 | 01:40:01 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:40:02 INFO - PROCESS | 1668 | RSS: Main: 314245120 01:40:02 INFO - PROCESS | 1668 | 01:40:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:40:04 INFO - PROCESS | 1668 | RSS: Main: 318861312 01:40:04 INFO - PROCESS | 1668 | 01:40:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:40:07 INFO - PROCESS | 1668 | RSS: Main: 327704576 01:40:07 INFO - PROCESS | 1668 | 01:40:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:40:11 INFO - PROCESS | 1668 | RSS: Main: 329715712 01:40:11 INFO - PROCESS | 1668 | 01:40:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:40:14 INFO - PROCESS | 1668 | RSS: Main: 331350016 01:40:14 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 01:40:16 INFO - PROCESS | 1668 | RSS: Main: 374579200 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | __start_tp_report 01:40:16 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 01:40:16 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 01:40:16 INFO - PROCESS | 1668 | |i|pagename|runs| 01:40:16 INFO - PROCESS | 1668 | |0;ai-astar;101;112;113;112;112;114;112;112;113;113 01:40:16 INFO - PROCESS | 1668 | |1;audio-beat-detection;142;111;107;166;109;105;124;107;143;108 01:40:16 INFO - PROCESS | 1668 | |2;audio-dft;183;203;264;201;182;180;184;181;184;185 01:40:16 INFO - PROCESS | 1668 | |3;audio-fft;78;58;61;85;57;59;88;69;77;75 01:40:16 INFO - PROCESS | 1668 | |4;audio-oscillator;86;70;100;70;70;69;97;71;68;101 01:40:16 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;87;83;88;84;87;84;87;85;85;85 01:40:16 INFO - PROCESS | 1668 | |6;imaging-darkroom;93;94;92;93;93;93;92;92;93;92 01:40:16 INFO - PROCESS | 1668 | |7;imaging-desaturate;81;79;84;84;84;85;86;85;84;84 01:40:16 INFO - PROCESS | 1668 | |8;json-parse-financial;53;53;52;54;54;52;54;52;53;52 01:40:16 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;67;74;72;77;72;72;72;70;71;72 01:40:16 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;86;81;83;85;85;86;85;87;85;118 01:40:16 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;140;150;156;137;150;148;145;139;150;139 01:40:16 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;165;166;165;164;165;165;164;164;166;163 01:40:16 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;68;67;67;65;66;66;67;66;65;65 01:40:16 INFO - PROCESS | 1668 | __end_tp_report 01:40:16 INFO - PROCESS | 1668 | __start_cc_report 01:40:16 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2019 01:40:16 INFO - PROCESS | 1668 | __end_cc_report 01:40:16 INFO - PROCESS | 1668 | __startTimestamp1470645616620__endTimestamp 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | ------- Summary: start ------- 01:40:16 INFO - PROCESS | 1668 | Number of tests: 14 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.72 (3.3%) stddev-sans-first:0.73 01:40:16 INFO - PROCESS | 1668 | Values: 101.0 112.0 113.0 112.0 112.0 114.0 112.0 112.0 113.0 113.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:117.50 stddev:21.10 (18.0%) stddev-sans-first:21.12 01:40:16 INFO - PROCESS | 1668 | Values: 142.0 111.0 107.0 166.0 109.0 105.0 124.0 107.0 143.0 108.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:194.70 Median:184.50 stddev:25.68 (13.9%) stddev-sans-first:26.89 01:40:16 INFO - PROCESS | 1668 | Values: 183.0 203.0 264.0 201.0 182.0 180.0 184.0 181.0 184.0 185.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:70.70 Median:76.00 stddev:11.54 (15.2%) stddev-sans-first:11.93 01:40:16 INFO - PROCESS | 1668 | Values: 78.0 58.0 61.0 85.0 57.0 59.0 88.0 69.0 77.0 75.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:70.00 stddev:14.19 (20.3%) stddev-sans-first:14.89 01:40:16 INFO - PROCESS | 1668 | Values: 86.0 70.0 100.0 70.0 70.0 69.0 97.0 71.0 68.0 101.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.00 stddev:1.65 (1.9%) stddev-sans-first:1.66 01:40:16 INFO - PROCESS | 1668 | Values: 87.0 83.0 88.0 84.0 87.0 84.0 87.0 85.0 85.0 85.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:40:16 INFO - PROCESS | 1668 | Values: 93.0 94.0 92.0 93.0 93.0 93.0 92.0 92.0 93.0 92.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:2.07 (2.5%) stddev-sans-first:1.96 01:40:16 INFO - PROCESS | 1668 | Values: 81.0 79.0 84.0 84.0 84.0 85.0 86.0 85.0 84.0 84.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 01:40:16 INFO - PROCESS | 1668 | Values: 53.0 53.0 52.0 54.0 54.0 52.0 54.0 52.0 53.0 52.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:2.56 (3.6%) stddev-sans-first:2.01 01:40:16 INFO - PROCESS | 1668 | Values: 67.0 74.0 72.0 77.0 72.0 72.0 72.0 70.0 71.0 72.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:85.00 stddev:10.64 (12.5%) stddev-sans-first:11.26 01:40:16 INFO - PROCESS | 1668 | Values: 86.0 81.0 83.0 85.0 85.0 86.0 85.0 87.0 85.0 118.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:149.00 stddev:6.36 (4.3%) stddev-sans-first:6.44 01:40:16 INFO - PROCESS | 1668 | Values: 140.0 150.0 156.0 137.0 150.0 148.0 145.0 139.0 150.0 139.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 01:40:16 INFO - PROCESS | 1668 | Values: 165.0 166.0 165.0 164.0 165.0 165.0 164.0 164.0 166.0 163.0 01:40:16 INFO - PROCESS | 1668 | 01:40:16 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:0.87 01:40:16 INFO - PROCESS | 1668 | Values: 68.0 67.0 67.0 65.0 66.0 66.0 67.0 66.0 65.0 65.0 01:40:16 INFO - PROCESS | 1668 | -------- Summary: end -------- 01:40:16 INFO - PROCESS | 1668 | 01:40:17 INFO - TEST-INFO | 1668: exit 0 01:40:17 INFO - TEST-OK | kraken | took 59155ms 01:40:17 INFO - SUITE-END | took 1177s 01:40:17 INFO - Completed test suite (00:19:37) 01:40:17 INFO - javascript benchmark 01:40:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.0, 3326.1850846542584, 3327.1016825457127, 3351.983240083799, 3419.726421886248, 5518.91721624176, 5557.7776888924445, 5621.437856214377, 5627.606067575277, 5665.5467562594995, 5409.702466364358, 5502.0921547944645, 5526.696031718254, 5548.611597188198, 5619.80330688427, 5090.287359769617, 5139.229115632666, 5156.53591176794, 5162.1224391853475, 5270.9736451317685, 5262.394824595163, 5269.736513174345, 5271.341082364705, 5272.156454967206, 5274.367075950891, 4846.176150054499, 4867.123917694814, 4890.462049174588, 5179.119549676564, 5255.921161182585, 4885.5358740919555, 4897.4123105227245, 4898.510148985109, 4905.068037072981, 4913.336699545587, 5079.161938280216, 5136.8698886244965, 5163.922541161885, 5210.192420174879, 5230.581553475713, 5406.0, 5469.453054694539, 5473.616846820724, 5502.642328248651, 5539.390667026624, 5853.50245229156, 5876.353601103875, 5934.0, 5938.168656388109, 5938.435848594377, 6000.249968753906, 6086.087086936995, 6132.938670613281, 6145.754169833202, 6146.217596896895, 5726.79956201531, 5776.277965254343, 5794.536437085023, 5800.419958004166, 5810.302763668386, 5830.950428922834, 6055.005762886994, 6381.744730210832, 6387.552871299057, 6402.391772781578, 5920.171176035358, 6004.669743164168, 6112.480439162632, 6122.112293717386, 6131.816045518642, 6116.914073580098, 6172.197614310111, 6196.566240363221, 6247.781327653511, 6261.24865016201, 6086.847828804315, 6156.168917196211, 6160.1375807387, 6185.072239164071, 6191.411815877575, 5989.9101513477335, 6117.847053823601, 6207.068939659087, 6216.44052035319, 6222.222222222223, 4851.878703032452, 4857.441394239708, 4886.657933944661, 4913.213885778258, 4913.533214344631, 4408.735475871394, 4412.271975124133, 4417.204903117469, 4435.667324950641, 4464.53122422141, 5666.575006874501, 5688.744006519716, 5694.117411801178, 5702.800401985911, 5721.199032135504, 6089.604175728564, 6153.538484613672, 6182.0, 6270.31026587075, 6303.275123360872, 5706.429357064343, 5709.714514274269, 5730.111832665943, 5733.541316694655, 5736.340320863154, 5179.015986962465, 5184.533391994739, 5192.688438693691, 5201.531862132426, 5202.3497062867145, 6185.536084793658, 6186.907196392148, 6199.969000155151, 6231.594946328474, 6251.062340648939, 6164.044573091178, 6244.718987645476, 6250.624962502265, 6311.0, 6319.747210111544, 6308.0, 6353.650549219838, 6363.459105976044, 6381.0, 6387.936120638734, 5903.498202652822, 6169.074638804036, 6176.938230617816, 6178.073289006685, 6191.969040154951, 6120.2947619997085, 6174.012158054869, 6179.227596550431, 6264.123022776906, 6284.591501552384, 5929.52563794904, 6038.667873266837, 6065.363136870742, 6072.878542429038, 6084.969575152096, 5811.970940145441, 6063.757449702139, 6063.909041364295, 6070.1198326241565, 6084.209052823105, 5827.8834423310445, 5894.675792831264, 5918.704064796829, 5991.550633702577, 5991.760329586942, 6018.909716354171, 6028.577999540165, 6078.756849725962, 6085.361037091042, 6087.969560152171, 5719.142128680731, 5800.9419905800405, 5891.05743081105, 5907.438793314628, 5920.319163296103], "value": 5630.26829518459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.27223268466213, 499.8353835563134, 509.9266044975327, 522.9827984570011, 542.0270614247426, 30428.391432171342, 39816.00459988502, 41142.38286425706, 41142.58857411425, 43231.351529727, 42388.364174537404, 42757.358639620354, 42794.71615851529, 42875.78562107185, 42983.0, 8664.8700269496, 9601.663941762057, 9825.361351512165, 9825.410475371466, 9826.213902887788, 8662.177093176138, 11483.13876459269, 11734.647960561197, 11737.94131029348, 12064.396780161002, 11801.232919860224, 11859.229150105259, 11865.110116741278, 11865.7626847463, 11873.287602743863, 11649.825252621218, 11695.35675537845, 11713.53145874164, 11714.297142171412, 11718.53125874964, 11585.246958947642, 11683.591074312444, 11688.240264382788, 11694.356810375426, 11728.237664551862, 39769.20461590781, 39944.400833987514, 40073.59926400757, 40094.39858402126, 40142.99642508961, 3388.8305584720665, 3548.8935331940083, 3606.765560238576, 3870.748401353931, 3900.824462899148, 31154.909578164883, 32007.51988720171, 32266.516002259985, 32319.6768032319, 32328.838355808304, 3262.1029216965285, 3346.4143774839304, 3347.8995630131135, 3379.9662003380145, 3383.661633836621, 512197.0, 512338.0, 513407.0, 513979.0, 514367.0, 58522.70738646365, 58672.0, 58706.706466467396, 58812.7059364709, 58896.705516472146, 61711.6914415434, 61839.6908015457, 61954.69022654858, 62046.0, 62091.689541552005, 14586.270686465634, 16072.9552579082, 16324.591885202964, 16354.672906541802, 16356.100414477318, 11454.713632159095, 11706.239094458833, 11709.531618735326, 11776.587819426279, 11936.403179841147, 15323.923380383027, 15973.520794375954, 16049.95675281103, 16057.839421605868, 16127.0, 4903.482031043463, 6277.7175027123885, 6300.1494798202575, 6336.746530138835, 6361.9045714314325, 905.2576886952767, 965.165132160676, 991.3258983891023, 996.7059717383389, 1070.3203465799274, 29178.854105729337, 29424.852875735483, 29593.852030740138, 29802.701972980427, 29906.401871962873, 1096.4408151842617, 1131.3890499130541, 1144.13046084976, 1163.9989608936307, 1227.0, 14764.704705906037, 15374.615634609001, 15449.691006179813, 15494.922525387301, 15780.13209273478, 617874.0, 686656.0, 692164.0, 692366.0, 693066.0, 58281.0, 58712.0, 58844.41155588475, 58935.0, 59430.10854837181, 1235.3452670084869, 1294.5922034559271, 1370.7327071221414, 1386.5840247925785, 1406.585057408067, 24324.513509729353, 25615.743842561336, 31062.534061988637, 31562.36875262436, 31768.841155795, 54975.0, 56704.0, 57042.7147864258, 59509.0, 59577.0, 504957.0, 507220.0, 508098.0, 509060.0, 509296.0, 26058.957641694877, 26187.607185891844, 26648.46703065889, 26770.866145669148, 26976.0, 47394.0, 47642.0, 47769.56691299267, 48204.0, 48526.786830329525, 38979.0, 39065.60934390734, 39172.41241381439, 40728.59271407248, 40757.38863916984, 38839.61160388473, 38953.610463895, 39148.80425597854, 39900.2019959605, 40430.595694042684, 38328.80835595804, 38742.6125738739, 38899.61100389073, 38967.80516097515, 38992.41511377388, 33738.156546086546, 34028.97913062612, 34874.9537513875, 34926.12684682903, 35096.0, 24332.0, 24853.25440236796, 25165.993360265384, 25567.0, 25839.70801459957], "value": 20317.708253299348, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.09148123397944, 368.0761289164197, 368.3369934118586, 373.2795704290719, 395.93269144245477, 16092.51722448327, 16641.750373744388, 20605.175792968264, 20611.175552977864, 20749.066292016858, 20953.476163095893, 20961.790382096173, 21570.676439853414, 21590.89204553979, 21744.238951636697, 6532.902006469907, 6588.407043366096, 6718.49611279156, 6815.250322464525, 6877.174739031323, 6672.699728512229, 6727.125473688414, 6773.661316934158, 6774.898376524356, 6795.0, 4406.272964960777, 5823.737931793058, 7681.155072941972, 7684.462087653867, 7754.340881025119, 7563.357114645261, 7622.390208783339, 7701.0758708955, 7750.0, 7788.649510772028, 7486.251374862524, 7526.134494533144, 7535.886961695579, 7535.9246407535775, 7539.623018849091, 25846.0, 26040.34899127537, 26562.33594160142, 29593.11220663362, 30183.245418864484, 2383.785459308653, 2454.361865914857, 2626.566616508274, 2983.74638155757, 3174.0319202643186, 17012.31950721982, 17071.061091639956, 17072.914635426743, 17656.735148972777, 17673.204705788143, 1880.6520793653217, 1902.1345287893976, 1923.778765441978, 1980.772211195702, 2091.581683663258, 101918.0, 108039.0, 132033.6796632031, 150853.9999999989, 150995.49004510033, 18079.276828926697, 19333.61332773337, 21084.0, 22078.33764987053, 22382.530707740327, 36741.0, 36830.63169368326, 36852.0, 36928.81535592359, 36955.63044369522, 9184.357095003286, 10845.511951962022, 10849.349039057683, 11067.0, 11110.500027498781, 8984.595693193822, 9016.8647470288, 9024.8646270306, 9225.308101892386, 9242.86135707965, 9525.14273715355, 9918.454485003394, 9943.502824858728, 9987.900120998842, 10027.197824174049, 3644.799536025544, 3742.288965096623, 3746.269477451871, 3755.962440375561, 3758.473813666089, 723.2080871445759, 761.7745205202477, 838.2372041442259, 867.5532100968006, 937.6108914800418, 21739.80431076306, 22150.0, 22185.44536386603, 22188.00153993074, 22188.667169992463, 860.7159637319669, 911.1571796088591, 911.9193755399872, 951.2152474208806, 966.5650457294246, 11069.612563560237, 11484.712882178012, 11492.080633549296, 11581.76836463266, 11586.652400428, 510998.0, 519841.0, 521610.0, 618475.0, 624016.0, 133963.0, 134444.32777836244, 141292.29353853164, 141895.0, 146356.53643463642, 964.9131578158, 993.1558175550869, 1021.6934919524261, 1024.7643042100358, 1027.5632856036154, 15490.612734681272, 18388.632227355647, 19849.610527263532, 20577.176912923915, 20672.89663551733, 37945.48218071246, 42358.57641423546, 47439.81400465016, 58173.4182658168, 61330.77338453295, 75877.62061189879, 77585.0, 80724.59637701773, 81456.0, 82847.0, 7032.613206273704, 7039.331263529956, 7391.556506609621, 8205.425620206766, 8461.915380846112, 12041.0, 12914.22514649124, 12934.353282335658, 13439.865601344252, 13525.797113043509, 11078.833817492905, 11176.329420234812, 11554.306741595195, 11612.361320127475, 11700.0, 9489.240860730986, 10893.07408870255, 10951.671449856518, 11594.188406811441, 11643.0, 11414.258073225214, 11511.19421640477, 11738.70653233676, 11870.703232419259, 11923.582674606347, 8109.918900810916, 8219.342452603658, 8293.21214484623, 8319.542425166674, 8391.916080839357, 8457.746267611981, 11136.888631113909, 11332.0, 11582.826257606312, 11680.883191167979], "value": 11029.693864079032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.1093333066826, 1511.954641360759, 1700.302875820913, 1831.8259765322289, 1899.591587808621, 8251.133630968752, 8797.824043519126, 8810.735677929664, 8814.60334284957, 8814.735557933273, 7747.767566973, 7973.60131993401, 8338.958305208465, 8563.058063612998, 8589.398742088057, 2308.3651995701234, 2332.9066837326486, 2337.614293641556, 2341.4497593065616, 2346.2609278077352, 2006.8695534790265, 2258.627326491127, 2291.1179196009575, 2295.116380193621, 2314.1900334882826, 2322.1872344679314, 2333.7666233376694, 2343.4610039690883, 2351.071326825903, 2354.470244195051, 2321.1527792355755, 2335.1593426366494, 2338.0297176671747, 2340.157543284416, 2345.683332750091, 2310.722713274401, 2310.803581695558, 2310.8960096795686, 2316.698829152216, 2318.362450326157, 8679.392442529026, 8710.782230444227, 8793.164649358301, 8796.120387961153, 8816.20654141124, 5083.822066227701, 5259.0270799901755, 5262.105442074857, 5265.052290587692, 5266.7629956652045, 3385.407553678121, 3444.689977902001, 3573.982130089359, 3595.0, 3595.6404359564094, 1082.734729991157, 1102.399192440122, 1772.459399883035, 1827.7898041725239, 1870.186468886039, 11441.313521188673, 11502.424878756112, 11522.769544609144, 11539.942300288445, 11541.019013383873, 4120.484939382577, 4328.696991210585, 4380.978095109568, 4387.561243875651, 4405.581469760367, 8997.685081022133, 9006.774830629287, 9016.684416045407, 9027.819443611092, 9033.457992520338, 4986.152354099811, 4987.825426110141, 4993.251012348177, 4993.500649934977, 5003.924941125886, 4097.262492751273, 4334.956650433518, 4480.910381792346, 4650.162970665313, 4842.346283251786, 3685.539307586552, 3714.23858109087, 3811.7141214408475, 3818.7326887117633, 3837.194189220295, 991.2961797123978, 991.8561808537866, 1123.971900702489, 1145.604766355606, 1159.1538177130742, 782.22950393862, 877.2455688108349, 899.5457294066455, 908.42315129893, 952.3048174832411, 5808.680522571299, 5998.3701711320555, 6005.519558435315, 6057.363976782374, 6100.572959892765, 925.8611208318806, 963.1812958984807, 966.3911735606663, 979.3634137810337, 1014.2038499777639, 3957.782321972262, 3971.146203566247, 3981.044549308145, 4032.737872038308, 4140.958590414058, 10342.482875856178, 10761.30051546647, 10762.946185269024, 10763.946180269206, 10776.245662803529, 10030.74923126913, 10474.37153770761, 10481.580736770597, 10680.198985075995, 10755.731106722395, 7244.311790379906, 7971.920280797234, 7978.920210797818, 8178.959105204555, 8186.754397368089, 5983.730732117152, 5990.820275391745, 6092.75628974836, 6153.13856060143, 6173.104899789595, 9725.416475011521, 10058.899411005796, 10097.444640544547, 10111.191104711459, 10117.949410252902, 9300.953495232481, 9576.904230957602, 9687.370320929118, 10240.436775977392, 10351.534180961724, 7270.636468176464, 7588.392928565812, 7592.620368981639, 7666.9616651916385, 7715.421343399155, 7951.721689740832, 8189.918100818915, 8270.669173233004, 8409.411341206056, 8415.200555947175, 7306.561606303639, 7367.1527774304495, 7419.22098179705, 7445.441591880739, 7503.512271702322, 7225.891611625935, 7242.348188663045, 7248.601326926859, 7256.1655409628565, 7294.96352518234, 6635.104260924713, 6852.246252912275, 6930.064441300561, 6968.233494315723, 7005.194402643761, 4797.8080876765935, 4833.613310935187, 4835.758212089452, 4953.504649535018, 4965.3296804932315, 4982.501749824988, 5068.543831055223, 5092.872678183075, 5142.228665700175, 5231.529162375405], "value": 4554.789950589385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.66626045089953, 310.71724730495254, 312.65763988432667, 317.50944790298973, 320.08455816365176, 5328.280682107919, 5330.0, 5382.811601593945, 5393.191021346795, 5426.430224826396, 4907.282451142099, 4913.705177689332, 5162.5611822995, 5385.0037743017565, 5403.918941215875, 3871.961280387195, 3922.41163825427, 4028.6777057835448, 4074.2258970795456, 4156.231097247004, 3381.0871064812486, 4018.377151541501, 4060.979695101535, 4106.691998100139, 4118.732282401649, 3999.6200360965663, 4007.7996100194873, 4039.474868267121, 4058.7970601469956, 4100.118474527976, 3796.4055096859383, 3800.391937290048, 3995.40068989651, 4065.999999999985, 4077.6145954616586, 2912.66504351998, 3226.709596136359, 3472.808995505246, 3477.739169562293, 3494.8951531454095, 4969.82605608802, 5202.401723801773, 5239.816606418795, 5247.932852039662, 5268.236105764681, 3893.364786789555, 4234.470691163605, 4596.908061838744, 4619.584237418615, 4642.605378542794, 5531.834044978657, 5554.3614633682755, 5580.944190558123, 5591.4688104629995, 5620.381758006616, 3774.830132644038, 3779.7354185207046, 3789.4315852622053, 3809.3904975204114, 3826.234753049401, 5650.830475085754, 5788.797392091299, 5900.468957793819, 5933.525317974551, 5941.851453713649, 3270.149761062141, 3356.009977056774, 3854.479645247912, 3871.8064096795047, 3899.805009749501, 3586.677199052098, 3726.925461490809, 3948.368261078214, 3964.345882929342, 3967.5238971323624, 4103.707332190351, 4529.886752831206, 4537.795799189044, 4555.931661025087, 4558.407407037064, 4606.723596584216, 4950.0, 5129.640085743844, 5669.744861481161, 5725.198472213893, 1323.9801402978962, 1344.213635023522, 1349.9055066145472, 1350.8176396186586, 1351.4526616720243, 680.6285335049879, 804.8691588318422, 819.1439945257221, 820.7906983719114, 835.8913341265718, 4377.781110944504, 5122.334096567422, 5140.511651393112, 5294.682319060792, 5303.090887280576, 5713.914291285634, 5746.856328591735, 5754.539636829044, 5799.3620701722775, 5806.593538452268, 4944.456109827916, 5252.474752524717, 5264.341957255343, 5265.894682106413, 5303.946960530346, 2405.6888995497497, 2968.2727731705872, 2998.565208044865, 3047.506721706348, 3052.2979714665753, 5063.468335824759, 5975.7609695612555, 5993.820185394445, 6023.759049638053, 6032.728527216286, 5223.022876960096, 5462.962037212917, 5531.778728850882, 5733.799317023884, 5946.07835785454, 5055.772490237875, 5911.103559256019, 5985.456181123005, 6001.279846418458, 6014.789482368096, 5459.645123066988, 5642.238297829905, 5773.3072031356505, 5776.566757493289, 5801.186424584158, 5169.586433085269, 5456.0, 5651.378348381592, 5753.769849205984, 5779.393163717918, 5933.703314834327, 5985.311689155803, 5997.880042399041, 5999.240349439307, 6013.632365875124, 2704.878280477344, 3288.556044933903, 3567.8751243706347, 3825.196708691206, 3897.0, 5766.538676905921, 5768.529025098741, 5771.336296325809, 5780.508656764222, 5804.533073443854, 5615.915761263666, 5655.321361436654, 5663.348714897675, 5665.753534222465, 5673.347565030074, 4712.0, 5427.972860135674, 5656.830295091154, 5667.971660141673, 5671.319441667027, 4432.0, 4735.697683137165, 4786.473487916396, 5560.110382338807, 5571.498565129158, 4718.834840780556, 4960.826371076995, 5498.477644623755, 5651.971740141273, 5726.656400615976, 4169.728232888998, 5011.271111466538, 5512.80705175317, 5586.86032849182, 5595.88082383533], "value": 4076.8495676783473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.8773358888355, 723.464636169235, 728.1844334345532, 766.4711349169073, 823.5388182617733, 15624.687506249882, 16617.91691041546, 16631.33474661015, 16657.167141642916, 16682.916585417057, 14846.703065938702, 14987.47543835966, 15025.774613380809, 15036.0, 15092.622684432894, 677.8068250548595, 710.6162672157029, 843.4222557548069, 860.6557377049184, 882.0561998661435, 870.8693695945595, 882.4528792148876, 882.9072947340533, 886.8891388576428, 890.3411475508142, 945.8486642137259, 946.2713710442955, 947.9194268487187, 950.980980380392, 951.6954574536152, 940.9952950235239, 944.9716508504756, 945.1399226703667, 945.6312038305067, 947.4504787223428, 515.914874045782, 658.8912829383194, 691.3225039461356, 692.5013989927244, 694.3577191098213, 15014.699706005818, 15018.924905375403, 15063.0, 15081.698366032619, 15108.0, 13896.861031389657, 14331.856681433157, 14437.35031923566, 14471.348789304506, 14544.2000689962, 13049.608511744664, 13182.34088295591, 13210.735785284336, 13456.192628442226, 13814.447422103103, 4583.0, 4760.738159401231, 4785.593224575915, 4803.111424386465, 4842.806287748486, 113542.0, 114155.42922285336, 120362.39818800938, 123323.0, 124739.12891306728, 10978.725531861608, 11451.427428628534, 11609.3614851184, 11739.178257521891, 11848.585299514649, 22628.208012719806, 23083.653745193835, 23129.884350578475, 23134.0, 23141.884290578775, 5996.850078747979, 7929.212705462952, 7986.720464783704, 7988.920110798817, 8202.179782021869, 4371.453568303962, 4416.1609294233995, 4482.618977386958, 4497.505274419811, 4633.606143477775, 3504.0539054455153, 3609.224016836393, 3625.728070394731, 3633.0372451300427, 3654.6528079832906, 547.5947798629065, 637.4135795068455, 654.499308029358, 664.1764212376714, 666.9166354205724, 593.2228780297824, 609.823151286131, 625.5339771869986, 640.2285246278224, 650.5186162239909, 8906.465612063297, 9090.454822558235, 9256.7685807854, 9444.197243234265, 9518.47648379332, 596.2517041113375, 601.4196300569971, 629.3454807000668, 631.2059905021356, 639.7409049335026, 4410.140022695544, 4438.467383913951, 4446.955530444654, 4491.108758010075, 4609.3086037094035, 118407.0, 121525.35423937296, 121530.0, 124824.0, 127713.36143319224, 88928.0, 110156.4492177534, 111783.88216117898, 113912.0, 116248.41875790736, 100130.0, 100592.0, 107325.46337268264, 108069.4596527028, 110123.0, 8658.696945606873, 8842.248408885316, 10096.444695541815, 10110.8483372748, 10131.189504839742, 58081.4191858076, 58273.66905323909, 58614.70692646509, 58749.831267717986, 59776.701116494136, 87028.0, 89350.55324723334, 93338.0, 93560.06439935513, 95204.0, 12627.3686315682, 13129.277889715775, 13193.14244574138, 13213.339333033118, 13914.860851391357, 14887.255637218312, 14957.40170393172, 14967.32647030908, 15085.47200847965, 15783.842161578237, 13801.861981380058, 13808.654783630489, 14239.572812815632, 14434.0, 14502.564923052325, 14139.575812725634, 14159.008869379044, 14318.284085795876, 14366.928165359524, 14738.484153054591, 13721.313934303445, 13736.386304262565, 13867.11636423509, 13892.305384730926, 14316.06945548536, 11108.222424430536, 11283.943580282046, 11681.06551475897, 11866.82199766987, 11916.523339066687, 10003.849942250727, 10385.0, 11263.127902385168, 11603.593874214363, 11634.476448559666], "value": 7903.647030892404, "unit": "score"}], "name": "dromaeo_css", "value": 7549.871624888839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 113.0, 112.0, 112.0, 114.0, 112.0, 112.0, 113.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 107.0, 166.0, 109.0, 105.0, 124.0, 107.0, 143.0, 108.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 203.0, 264.0, 201.0, 182.0, 180.0, 184.0, 181.0, 184.0, 185.0], "value": 194.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 61.0, 85.0, 57.0, 59.0, 88.0, 69.0, 77.0, 75.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 100.0, 70.0, 70.0, 69.0, 97.0, 71.0, 68.0, 101.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 88.0, 84.0, 87.0, 84.0, 87.0, 85.0, 85.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 92.0, 93.0, 93.0, 93.0, 92.0, 92.0, 93.0, 92.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 84.0, 84.0, 84.0, 85.0, 86.0, 85.0, 84.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 54.0, 54.0, 52.0, 54.0, 52.0, 53.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 72.0, 77.0, 72.0, 72.0, 72.0, 70.0, 71.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 83.0, 85.0, 85.0, 86.0, 85.0, 87.0, 85.0, 118.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 150.0, 156.0, 137.0, 150.0, 148.0, 145.0, 139.0, 150.0, 139.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 165.0, 164.0, 165.0, 165.0, 164.0, 164.0, 166.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1430.2000000000003, "alertThreshold": 2.0}]} 01:40:17 INFO - Return code: 0 01:40:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:40:17 INFO - # TBPL SUCCESS # 01:40:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:40:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:40:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:40:17 INFO - 2016-08-08 01:40:17.954 screenresolution[1672:9798] starting screenresolution argv=screenresolution get 01:40:17 INFO - 2016-08-08 01:40:17.956 screenresolution[1672:9798] Display 0: 1600x1200x32@60 01:40:17 INFO - 2016-08-08 01:40:17.962 screenresolution[1673:9801] starting screenresolution argv=screenresolution list 01:40:17 INFO - Available Modes on Display 0 01:40:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:40:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:40:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:40:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:40:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:40:18 INFO - Intel Iris: 01:40:18 INFO - Chipset Model: Intel Iris 01:40:18 INFO - Type: GPU 01:40:18 INFO - Bus: Built-In 01:40:18 INFO - VRAM (Dynamic, Max): 1536 MB 01:40:18 INFO - Vendor: Intel (0x8086) 01:40:18 INFO - Device ID: 0x0a2e 01:40:18 INFO - Revision ID: 0x0009 01:40:18 INFO - Displays: 01:40:18 INFO - Display: 01:40:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:40:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:40:18 INFO - Display Serial Number: 1600x1200 60 01:40:18 INFO - Main Display: Yes 01:40:18 INFO - Mirror: Off 01:40:18 INFO - Online: Yes 01:40:18 INFO - Rotation: Supported 01:40:18 INFO - Return code: 0 01:40:18 INFO - Running post-action listener: _resource_record_post_action 01:40:18 INFO - [mozharness: 2016-08-08 08:40:18.209639Z] Finished run-tests step (success) 01:40:18 INFO - Running post-run listener: _resource_record_post_run 01:40:18 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37094400; Write bytes: 702124544; Read time: 236; Write time: 1933 01:40:18 INFO - TinderboxPrint: CPU usage
53.6% 01:40:18 INFO - TinderboxPrint: I/O read bytes / time
37,094,400 / 236 01:40:18 INFO - TinderboxPrint: I/O write bytes / time
702,124,544 / 1,933 01:40:18 INFO - TinderboxPrint: CPU idle
2,249.2 (46.4%) 01:40:18 INFO - TinderboxPrint: CPU system
970.9 (20.0%) 01:40:18 INFO - TinderboxPrint: CPU user
1,629.5 (33.6%) 01:40:18 INFO - TinderboxPrint: Swap in / out
443,891,712 / 0 01:40:18 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394230272; Write bytes: 388244992; Read time: 29222; Write time: 811 01:40:18 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35300352; Write bytes: 291920896; Read time: 220; Write time: 1071 01:40:18 INFO - Running post-run listener: _upload_blobber_files 01:40:18 INFO - Blob upload gear active. 01:40:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:40:18 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 01:40:18 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'] 01:40:18 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 01:40:19 INFO - (blobuploader) - INFO - Open directory for files ... 01:40:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:40:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:40:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:20 INFO - (blobuploader) - INFO - Done attempting. 01:40:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:40:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:40:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:21 INFO - (blobuploader) - INFO - Done attempting. 01:40:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:40:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:40:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:40:23 INFO - (blobuploader) - INFO - Done attempting. 01:40:23 INFO - (blobuploader) - INFO - Iteration through files over. 01:40:23 INFO - Return code: 0 01:40:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:40:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:40:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/db50e0ecd2dafe2b48d63ebad4cfb8872bcd99e04e646fc44695b5e272fabee07ef54cbf34c5cbb3a3c481007033737315ee223a664db5595d2071caddc2350e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fbccaf5b4662a82531aac5dd8ec3b1f84178dd0955f634830d5bec5a37fae4bdf23f73592725cd385777133758bd111bfc996b53c0e34ae6218feedee8ba29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84ee297c02e262bd9aa06547a14912e839c348305fb86938dbdae7a7b84844e24078529ee5059bb0ea903e2a45c25c1c899be68302c0b6ead9cf30c2fcff9518"} 01:40:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:40:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:40:23 INFO - Contents: 01:40:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/db50e0ecd2dafe2b48d63ebad4cfb8872bcd99e04e646fc44695b5e272fabee07ef54cbf34c5cbb3a3c481007033737315ee223a664db5595d2071caddc2350e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fbccaf5b4662a82531aac5dd8ec3b1f84178dd0955f634830d5bec5a37fae4bdf23f73592725cd385777133758bd111bfc996b53c0e34ae6218feedee8ba29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84ee297c02e262bd9aa06547a14912e839c348305fb86938dbdae7a7b84844e24078529ee5059bb0ea903e2a45c25c1c899be68302c0b6ead9cf30c2fcff9518"} 01:40:23 INFO - Running post-run listener: copy_logs_to_upload_dir 01:40:23 INFO - Copying logs to upload dir... 01:40:23 INFO - mkdir: /builds/slave/test/build/upload/logs 01:40:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.322748 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 01:40:23.333225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 01:40:23.336401) ========= 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.5AljK5yn9w/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.RcnY60MImg/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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/db50e0ecd2dafe2b48d63ebad4cfb8872bcd99e04e646fc44695b5e272fabee07ef54cbf34c5cbb3a3c481007033737315ee223a664db5595d2071caddc2350e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fbccaf5b4662a82531aac5dd8ec3b1f84178dd0955f634830d5bec5a37fae4bdf23f73592725cd385777133758bd111bfc996b53c0e34ae6218feedee8ba29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84ee297c02e262bd9aa06547a14912e839c348305fb86938dbdae7a7b84844e24078529ee5059bb0ea903e2a45c25c1c899be68302c0b6ead9cf30c2fcff9518"} build_url:https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/GeR37mwSTmuDl093UTI75g/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/db50e0ecd2dafe2b48d63ebad4cfb8872bcd99e04e646fc44695b5e272fabee07ef54cbf34c5cbb3a3c481007033737315ee223a664db5595d2071caddc2350e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fbccaf5b4662a82531aac5dd8ec3b1f84178dd0955f634830d5bec5a37fae4bdf23f73592725cd385777133758bd111bfc996b53c0e34ae6218feedee8ba29e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84ee297c02e262bd9aa06547a14912e839c348305fb86938dbdae7a7b84844e24078529ee5059bb0ea903e2a45c25c1c899be68302c0b6ead9cf30c2fcff9518"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 01:40:23.370152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:40:23.370529) ========= 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.5AljK5yn9w/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.RcnY60MImg/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.005048 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 01:40:23.419702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 01:40:23.420134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 01:40:23.420560) ========= ========= Total master_lag: 0.18 =========