builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0035 starttime: 1470566188.45 results: success (0) buildid: 20160807001853 builduid: 8d764c5a7a4245729e13375ab54726ee revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.451360) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.451761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.452033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.607639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:28.607898) ========= 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.NTBY49BSgy/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.D8cwzTVtJF/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-07 03:36:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.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% 10.5M=0.001s 2016-08-07 03:36:29 (10.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.487540 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:29.132085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:29.132391) ========= 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.NTBY49BSgy/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.D8cwzTVtJF/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.020626 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:29.193311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 03:36:29.193635) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NTBY49BSgy/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.D8cwzTVtJF/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-07 03:36:29,275 truncating revision to first 12 chars 2016-08-07 03:36:29,275 Setting DEBUG logging. 2016-08-07 03:36:29,275 attempt 1/10 2016-08-07 03:36:29,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42aacfe34af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 03:36:30,261 unpacking tar archive at: fx-team-d42aacfe34af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251073 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 03:36:30.482147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.482424) ========= script_repo_revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.482814) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.483108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 03:36:30.517309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-07 03:36:30.517591) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NTBY49BSgy/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.D8cwzTVtJF/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:36:30 INFO - MultiFileLogger online at 20160807 03:36:30 in /builds/slave/test 03:36:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:36:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:30 INFO - {'append_to_log': False, 03:36:30 INFO - 'base_work_dir': '/builds/slave/test', 03:36:30 INFO - 'blob_upload_branch': 'Fx-Team', 03:36:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:30 INFO - 'branch': 'Fx-Team', 03:36:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:30 INFO - 'config_files': ('talos/mac_config.py',), 03:36:30 INFO - 'default_actions': ('clobber', 03:36:30 INFO - 'read-buildbot-config', 03:36:30 INFO - 'download-and-extract', 03:36:30 INFO - 'populate-webroot', 03:36:30 INFO - 'create-virtualenv', 03:36:30 INFO - 'install', 03:36:30 INFO - 'run-tests'), 03:36:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:30 INFO - 'download_minidump_stackwalk': True, 03:36:30 INFO - 'download_symbols': 'ondemand', 03:36:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:30 INFO - 'installer_path': 'installer.exe', 03:36:30 INFO - 'log_level': 'info', 03:36:30 INFO - 'log_name': 'talos', 03:36:30 INFO - 'log_to_console': True, 03:36:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:36:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:36:30 INFO - 'opt_config_files': (), 03:36:30 INFO - 'pip_index': False, 03:36:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:30 INFO - 'cmd': ('bash', 03:36:30 INFO - '-c', 03:36:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:30 INFO - 'enabled': True, 03:36:30 INFO - 'halt_on_failure': False, 03:36:30 INFO - 'name': 'check_screen_resolution'},), 03:36:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:30 INFO - 'cmd': ('bash', 03:36:30 INFO - '-c', 03:36:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:30 INFO - 'enabled': True, 03:36:30 INFO - 'halt_on_failure': False, 03:36:30 INFO - 'name': 'check_screen_resolution'},), 03:36:30 INFO - 'run_cmd_checks_enabled': True, 03:36:30 INFO - 'sps_profile': False, 03:36:30 INFO - 'sps_profile_interval': 0, 03:36:30 INFO - 'suite': 'dromaeojs-e10s', 03:36:30 INFO - 'system_bits': '32', 03:36:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:30 INFO - 'title': 't-yosemite-r7-0035', 03:36:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:30 INFO - 'use_talos_json': True, 03:36:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:30 INFO - 'work_dir': 'build'} 03:36:30 INFO - [mozharness: 2016-08-07 10:36:30.701374Z] Running clobber step. 03:36:30 INFO - Running pre-action listener: _resource_record_pre_action 03:36:30 INFO - Running main action method: clobber 03:36:30 INFO - rmtree: /builds/slave/test/build 03:36:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:31 INFO - Running post-action listener: _resource_record_post_action 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.598577Z] Finished clobber step (success) 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.598691Z] Running read-buildbot-config step. 03:36:31 INFO - Running pre-action listener: _resource_record_pre_action 03:36:31 INFO - Running main action method: read_buildbot_config 03:36:31 INFO - Using buildbot properties: 03:36:31 INFO - { 03:36:31 INFO - "project": "", 03:36:31 INFO - "product": "firefox", 03:36:31 INFO - "script_repo_revision": "production", 03:36:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:36:31 INFO - "repository": "", 03:36:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:36:31 INFO - "buildid": "20160807001853", 03:36:31 INFO - "pgo_build": "False", 03:36:31 INFO - "basedir": "/builds/slave/test", 03:36:31 INFO - "buildnumber": 70, 03:36:31 INFO - "slavename": "t-yosemite-r7-0035", 03:36:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:36:31 INFO - "platform": "yosemite_r7", 03:36:31 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 03:36:31 INFO - "branch": "fx-team", 03:36:31 INFO - "repo_path": "integration/fx-team", 03:36:31 INFO - "revision": "d42aacfe34af25e2f5110e2ca3d24a210eabeb33", 03:36:31 INFO - "stage_platform": "macosx64", 03:36:31 INFO - "builduid": "8d764c5a7a4245729e13375ab54726ee", 03:36:31 INFO - "slavebuilddir": "test" 03:36:31 INFO - } 03:36:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 03:36:31 INFO - Running post-action listener: _resource_record_post_action 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.601573Z] Finished read-buildbot-config step (success) 03:36:31 INFO - [mozharness: 2016-08-07 10:36:31.601675Z] Running download-and-extract step. 03:36:31 INFO - Running pre-action listener: _resource_record_pre_action 03:36:31 INFO - Running main action method: download_and_extract 03:36:31 INFO - mkdir: /builds/slave/test/build/tests 03:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:31 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 03:36:31 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 03:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 03:36:32 INFO - Downloaded 1199 bytes. 03:36:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 03:36:32 INFO - Using the following test package requirements: 03:36:32 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:36:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 03:36:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 03:36:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'jsshell-mac.zip'], 03:36:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 03:36:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:36:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 03:36:32 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 03:36:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 03:36:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:36:32 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 03:36:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:32 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:36:32 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:36:33 INFO - Downloaded 16324165 bytes. 03:36:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:36:36 INFO - Return code: 0 03:36:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:36 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:36:36 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:36:37 INFO - Downloaded 16324165 bytes. 03:36:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:36:41 INFO - Return code: 0 03:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:41 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 03:36:41 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 03:36:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:36:43 INFO - Downloaded 14413723 bytes. 03:36:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:36:43 INFO - Return code: 0 03:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:43 INFO - trying https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:36:43 INFO - Downloading https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 03:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 03:36:50 INFO - Downloaded 111873052 bytes. 03:36:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:36:50 INFO - mkdir: /builds/slave/test/properties 03:36:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:50 INFO - Contents: 03:36:50 INFO - build_url:https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:36:50 INFO - Running post-action listener: _resource_record_post_action 03:36:50 INFO - Running post-action listener: set_extra_try_arguments 03:36:50 INFO - [mozharness: 2016-08-07 10:36:50.685469Z] Finished download-and-extract step (success) 03:36:50 INFO - [mozharness: 2016-08-07 10:36:50.685571Z] Running populate-webroot step. 03:36:50 INFO - Running pre-action listener: _resource_record_pre_action 03:36:50 INFO - Running main action method: populate_webroot 03:36:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:50 INFO - '--tppagecycles', 03:36:50 INFO - '7'], 03:36:50 INFO - 'tests': ['tsvgm']}}, 03:36:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['damp', 'tps']}, 03:36:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'tests': ['damp', 'tps']}, 03:36:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['dromaeo_dom']}, 03:36:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['basic_compositor_video']}, 03:36:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:36:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tsvgx', 03:36:50 INFO - 'tsvgr_opacity', 03:36:50 INFO - 'tart', 03:36:50 INFO - 'tscrollx', 03:36:50 INFO - 'cart']}, 03:36:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:50 INFO - 'tsvgr_opacity', 03:36:50 INFO - 'tart', 03:36:50 INFO - 'tscrollx', 03:36:50 INFO - 'cart']}, 03:36:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tp5o']}, 03:36:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'tests': ['tp5o']}, 03:36:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s', 03:36:50 INFO - '--xperf_path', 03:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:50 INFO - 'tests': ['tp5n']}, 03:36:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--xperf_path', 03:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:50 INFO - 'tests': ['tp5n']}}, 03:36:50 INFO - 'talos.zip': {'path': '', 03:36:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:50 INFO - Running post-action listener: _resource_record_post_action 03:36:50 INFO - [mozharness: 2016-08-07 10:36:50.704406Z] Finished populate-webroot step (success) 03:36:50 INFO - [mozharness: 2016-08-07 10:36:50.704536Z] Running create-virtualenv step. 03:36:50 INFO - Running pre-action listener: _resource_record_pre_action 03:36:50 INFO - Running main action method: create_virtualenv 03:36:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:36:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:50 INFO - Using real prefix '/tools/python27' 03:36:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:54 INFO - Installing pip.................done. 03:36:54 INFO - Return code: 0 03:36:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:54 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:54 INFO - 'HOME': '/Users/cltbld', 03:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:54 INFO - 'LOGNAME': 'cltbld', 03:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:54 INFO - 'MOZ_NO_REMOTE': '1', 03:36:54 INFO - 'NO_EM_RESTART': '1', 03:36:54 INFO - 'PAGER': '/bin/cat', 03:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:54 INFO - 'PWD': '/builds/slave/test', 03:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:54 INFO - 'SHELL': '/bin/bash', 03:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:36:54 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:54 INFO - 'USER': 'cltbld', 03:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:54 INFO - 'XPC_FLAGS': '0x0', 03:36:54 INFO - 'XPC_SERVICE_NAME': '0', 03:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:36:54 INFO - Cleaning up... 03:36:54 INFO - Return code: 0 03:36:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:54 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:54 INFO - 'HOME': '/Users/cltbld', 03:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:54 INFO - 'LOGNAME': 'cltbld', 03:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:54 INFO - 'MOZ_NO_REMOTE': '1', 03:36:54 INFO - 'NO_EM_RESTART': '1', 03:36:54 INFO - 'PAGER': '/bin/cat', 03:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:54 INFO - 'PWD': '/builds/slave/test', 03:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:54 INFO - 'SHELL': '/bin/bash', 03:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:36:54 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:54 INFO - 'USER': 'cltbld', 03:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:54 INFO - 'XPC_FLAGS': '0x0', 03:36:54 INFO - 'XPC_SERVICE_NAME': '0', 03:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:54 INFO - Downloading/unpacking psutil>=3.1.1 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:57 INFO - Installing collected packages: psutil 03:36:57 INFO - Running setup.py install for psutil 03:36:57 INFO - building 'psutil._psutil_osx' extension 03:36:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:36:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:36:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:36:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:36:58 INFO - building 'psutil._psutil_posix' extension 03:36:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:36:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:36:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:36:58 INFO - ^ 03:36:58 INFO - 1 warning generated. 03:36:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:58 INFO - Successfully installed psutil 03:36:58 INFO - Cleaning up... 03:36:58 INFO - Return code: 0 03:36:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:36:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:58 INFO - 'HOME': '/Users/cltbld', 03:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:58 INFO - 'LOGNAME': 'cltbld', 03:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:58 INFO - 'MOZ_NO_REMOTE': '1', 03:36:58 INFO - 'NO_EM_RESTART': '1', 03:36:58 INFO - 'PAGER': '/bin/cat', 03:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:58 INFO - 'PWD': '/builds/slave/test', 03:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:58 INFO - 'SHELL': '/bin/bash', 03:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:36:58 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:58 INFO - 'USER': 'cltbld', 03:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:58 INFO - 'XPC_FLAGS': '0x0', 03:36:58 INFO - 'XPC_SERVICE_NAME': '0', 03:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:37:01 INFO - Installing collected packages: mozsystemmonitor 03:37:01 INFO - Running setup.py install for mozsystemmonitor 03:37:01 INFO - Successfully installed mozsystemmonitor 03:37:01 INFO - Cleaning up... 03:37:01 INFO - Return code: 0 03:37:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:01 INFO - 'HOME': '/Users/cltbld', 03:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:01 INFO - 'LOGNAME': 'cltbld', 03:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:01 INFO - 'MOZ_NO_REMOTE': '1', 03:37:01 INFO - 'NO_EM_RESTART': '1', 03:37:01 INFO - 'PAGER': '/bin/cat', 03:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:01 INFO - 'PWD': '/builds/slave/test', 03:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:01 INFO - 'SHELL': '/bin/bash', 03:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:01 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:01 INFO - 'USER': 'cltbld', 03:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:01 INFO - 'XPC_FLAGS': '0x0', 03:37:01 INFO - 'XPC_SERVICE_NAME': '0', 03:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:04 INFO - warning: no files found matching '*.txt' 03:37:04 INFO - no previously-included directories found matching 'build' 03:37:04 INFO - no previously-included directories found matching 'dist' 03:37:04 INFO - no previously-included directories found matching '.git*' 03:37:04 INFO - Installing collected packages: jsonschema, functools32 03:37:05 INFO - Running setup.py install for functools32 03:37:05 INFO - warning: no files found matching '*.txt' 03:37:05 INFO - no previously-included directories found matching 'build' 03:37:05 INFO - no previously-included directories found matching 'dist' 03:37:05 INFO - no previously-included directories found matching '.git*' 03:37:05 INFO - Successfully installed jsonschema functools32 03:37:05 INFO - Cleaning up... 03:37:05 INFO - Return code: 0 03:37:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:05 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:05 INFO - 'HOME': '/Users/cltbld', 03:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:05 INFO - 'LOGNAME': 'cltbld', 03:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:05 INFO - 'MOZ_NO_REMOTE': '1', 03:37:05 INFO - 'NO_EM_RESTART': '1', 03:37:05 INFO - 'PAGER': '/bin/cat', 03:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:05 INFO - 'PWD': '/builds/slave/test', 03:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:05 INFO - 'SHELL': '/bin/bash', 03:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:05 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:05 INFO - 'USER': 'cltbld', 03:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:05 INFO - 'XPC_FLAGS': '0x0', 03:37:05 INFO - 'XPC_SERVICE_NAME': '0', 03:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:05 INFO - Cleaning up... 03:37:05 INFO - Return code: 0 03:37:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:05 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:05 INFO - 'HOME': '/Users/cltbld', 03:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:05 INFO - 'LOGNAME': 'cltbld', 03:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:05 INFO - 'MOZ_NO_REMOTE': '1', 03:37:05 INFO - 'NO_EM_RESTART': '1', 03:37:05 INFO - 'PAGER': '/bin/cat', 03:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:05 INFO - 'PWD': '/builds/slave/test', 03:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:05 INFO - 'SHELL': '/bin/bash', 03:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:05 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:05 INFO - 'USER': 'cltbld', 03:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:05 INFO - 'XPC_FLAGS': '0x0', 03:37:05 INFO - 'XPC_SERVICE_NAME': '0', 03:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:09 INFO - Downloading docopt-0.6.1.tar.gz 03:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:09 INFO - Running setup.py install for blobuploader 03:37:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:09 INFO - Running setup.py install for requests 03:37:10 INFO - Running setup.py install for docopt 03:37:10 INFO - Successfully installed blobuploader requests docopt 03:37:10 INFO - Cleaning up... 03:37:10 INFO - Return code: 0 03:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:10 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:10 INFO - 'HOME': '/Users/cltbld', 03:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:10 INFO - 'LOGNAME': 'cltbld', 03:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:10 INFO - 'MOZ_NO_REMOTE': '1', 03:37:10 INFO - 'NO_EM_RESTART': '1', 03:37:10 INFO - 'PAGER': '/bin/cat', 03:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:10 INFO - 'PWD': '/builds/slave/test', 03:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:10 INFO - 'SHELL': '/bin/bash', 03:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:10 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:10 INFO - 'USER': 'cltbld', 03:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:10 INFO - 'XPC_FLAGS': '0x0', 03:37:10 INFO - 'XPC_SERVICE_NAME': '0', 03:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:10 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-dW2UlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:10 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ucpzSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:10 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-bVLWXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:10 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-MhLYmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-2wfTav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-WwvuP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-qeI1OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-rRWyrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-OmKFb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-VkELr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-iK2M3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-LxkUhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:11 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-xEti6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:12 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ML1Fkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:12 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-MWzbQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:12 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-9dVQHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:12 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-s4fQke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:12 INFO - Running setup.py install for manifestparser 03:37:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:12 INFO - Running setup.py install for mozcrash 03:37:12 INFO - Running setup.py install for mozdebug 03:37:12 INFO - Running setup.py install for mozdevice 03:37:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Running setup.py install for mozfile 03:37:13 INFO - Running setup.py install for mozhttpd 03:37:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Running setup.py install for mozinfo 03:37:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Running setup.py install for mozInstall 03:37:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Running setup.py install for mozleak 03:37:13 INFO - Running setup.py install for mozlog 03:37:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:13 INFO - Running setup.py install for moznetwork 03:37:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:14 INFO - Running setup.py install for mozprocess 03:37:14 INFO - Running setup.py install for mozprofile 03:37:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:14 INFO - Running setup.py install for mozrunner 03:37:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:14 INFO - Running setup.py install for mozscreenshot 03:37:14 INFO - Running setup.py install for moztest 03:37:14 INFO - Running setup.py install for mozversion 03:37:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:14 INFO - Cleaning up... 03:37:15 INFO - Return code: 0 03:37:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:15 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:15 INFO - 'HOME': '/Users/cltbld', 03:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:15 INFO - 'LOGNAME': 'cltbld', 03:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:15 INFO - 'MOZ_NO_REMOTE': '1', 03:37:15 INFO - 'NO_EM_RESTART': '1', 03:37:15 INFO - 'PAGER': '/bin/cat', 03:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:15 INFO - 'PWD': '/builds/slave/test', 03:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:15 INFO - 'SHELL': '/bin/bash', 03:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:15 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:15 INFO - 'USER': 'cltbld', 03:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:15 INFO - 'XPC_FLAGS': '0x0', 03:37:15 INFO - 'XPC_SERVICE_NAME': '0', 03:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:15 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-SXmhoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:15 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-zlLDlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:15 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-FcA2fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:15 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-P5rAcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:15 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-vOJugj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:15 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-7nLs6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:15 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-QhmN4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Ep8OTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-vsTHRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ZSbeNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-zC4Rta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-mSdxga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-dB3kw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-4PDhVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-9a8lzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-6Ikiz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:16 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-DPt97k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:19 INFO - Downloading blessings-1.6.tar.gz 03:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:19 INFO - Installing collected packages: blessings 03:37:19 INFO - Running setup.py install for blessings 03:37:19 INFO - Successfully installed blessings 03:37:19 INFO - Cleaning up... 03:37:19 INFO - Return code: 0 03:37:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:20 INFO - Reading from file tmpfile_stdout 03:37:20 INFO - Current package versions: 03:37:20 INFO - blessings == 1.6 03:37:20 INFO - blobuploader == 1.2.4 03:37:20 INFO - docopt == 0.6.1 03:37:20 INFO - functools32 == 3.2.3-2 03:37:20 INFO - jsonschema == 2.5.1 03:37:20 INFO - manifestparser == 1.1 03:37:20 INFO - mozInstall == 1.12 03:37:20 INFO - mozcrash == 0.17 03:37:20 INFO - mozdebug == 0.1 03:37:20 INFO - mozdevice == 0.48 03:37:20 INFO - mozfile == 1.2 03:37:20 INFO - mozhttpd == 0.7 03:37:20 INFO - mozinfo == 0.9 03:37:20 INFO - mozleak == 0.1 03:37:20 INFO - mozlog == 3.3 03:37:20 INFO - moznetwork == 0.27 03:37:20 INFO - mozprocess == 0.23 03:37:20 INFO - mozprofile == 0.28 03:37:20 INFO - mozrunner == 6.12 03:37:20 INFO - mozscreenshot == 0.1 03:37:20 INFO - mozsystemmonitor == 0.3 03:37:20 INFO - moztest == 0.7 03:37:20 INFO - mozversion == 1.4 03:37:20 INFO - psutil == 3.1.1 03:37:20 INFO - requests == 1.2.3 03:37:20 INFO - wsgiref == 0.1.2 03:37:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:20 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 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:20 INFO - 'HOME': '/Users/cltbld', 03:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:20 INFO - 'LOGNAME': 'cltbld', 03:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:20 INFO - 'MOZ_NO_REMOTE': '1', 03:37:20 INFO - 'NO_EM_RESTART': '1', 03:37:20 INFO - 'PAGER': '/bin/cat', 03:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:20 INFO - 'PWD': '/builds/slave/test', 03:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:20 INFO - 'SHELL': '/bin/bash', 03:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:20 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:20 INFO - 'USER': 'cltbld', 03:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:20 INFO - 'XPC_FLAGS': '0x0', 03:37:20 INFO - 'XPC_SERVICE_NAME': '0', 03:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:37:20 INFO - Cleaning up... 03:37:20 INFO - Return code: 0 03:37:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106473a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f3c97cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.NTBY49BSgy/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.D8cwzTVtJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:20 INFO - 'HOME': '/Users/cltbld', 03:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:20 INFO - 'LOGNAME': 'cltbld', 03:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:20 INFO - 'MOZ_NO_REMOTE': '1', 03:37:20 INFO - 'NO_EM_RESTART': '1', 03:37:20 INFO - 'PAGER': '/bin/cat', 03:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:20 INFO - 'PWD': '/builds/slave/test', 03:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:20 INFO - 'SHELL': '/bin/bash', 03:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:20 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:20 INFO - 'USER': 'cltbld', 03:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:20 INFO - 'XPC_FLAGS': '0x0', 03:37:20 INFO - 'XPC_SERVICE_NAME': '0', 03:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:20 INFO - Cleaning up... 03:37:20 INFO - Return code: 0 03:37:20 INFO - Running post-action listener: _resource_record_post_action 03:37:20 INFO - Running post-action listener: _start_resource_monitoring 03:37:20 INFO - Starting resource monitoring. 03:37:20 INFO - [mozharness: 2016-08-07 10:37:20.750303Z] Finished create-virtualenv step (success) 03:37:20 INFO - [mozharness: 2016-08-07 10:37:20.751260Z] Running install step. 03:37:20 INFO - Running pre-action listener: _resource_record_pre_action 03:37:20 INFO - Running main action method: install 03:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:21 INFO - Reading from file tmpfile_stdout 03:37:21 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:21 INFO - Reading from file tmpfile_stdout 03:37:21 INFO - Output received: 03:37:21 INFO - Usage: mozinstall [options] installer 03:37:21 INFO - Options: 03:37:21 INFO - -h, --help show this help message and exit 03:37:21 INFO - -d DEST, --destination=DEST 03:37:21 INFO - Directory to install application into. [default: 03:37:21 INFO - "/builds/slave/test"] 03:37:21 INFO - --app=APP Application being installed. [default: firefox] 03:37:21 INFO - mkdir: /builds/slave/test/build/application 03:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:37:55 INFO - Reading from file tmpfile_stdout 03:37:55 INFO - Output received: 03:37:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:37:55 INFO - Running post-action listener: _resource_record_post_action 03:37:55 INFO - [mozharness: 2016-08-07 10:37:55.147490Z] Finished install step (success) 03:37:55 INFO - [mozharness: 2016-08-07 10:37:55.147629Z] Running run-tests step. 03:37:55 INFO - Running pre-action listener: _resource_record_pre_action 03:37:55 INFO - Running main action method: run_tests 03:37:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:37:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:37:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:37:55 INFO - 2016-08-07 03:37:55.162 screenresolution[2177:11454] starting screenresolution argv=screenresolution get 03:37:55 INFO - 2016-08-07 03:37:55.164 screenresolution[2177:11454] Display 0: 1600x1200x32@60 03:37:55 INFO - 2016-08-07 03:37:55.170 screenresolution[2178:11456] starting screenresolution argv=screenresolution list 03:37:55 INFO - Available Modes on Display 0 03:37:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:37:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:37:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:37:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:37:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:37:55 INFO - Intel Iris: 03:37:55 INFO - Chipset Model: Intel Iris 03:37:55 INFO - Type: GPU 03:37:55 INFO - Bus: Built-In 03:37:55 INFO - VRAM (Dynamic, Max): 1536 MB 03:37:55 INFO - Vendor: Intel (0x8086) 03:37:55 INFO - Device ID: 0x0a2e 03:37:55 INFO - Revision ID: 0x0009 03:37:55 INFO - Displays: 03:37:55 INFO - Display: 03:37:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:37:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:37:55 INFO - Display Serial Number: 1600x1200 60 03:37:55 INFO - Main Display: Yes 03:37:55 INFO - Mirror: Off 03:37:55 INFO - Online: Yes 03:37:55 INFO - Rotation: Supported 03:37:55 INFO - Return code: 0 03:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:55 INFO - Python 2.7.3 03:37:55 INFO - Return code: 0 03:37:55 INFO - grabbing minidump binary from tooltool 03:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:55 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 0x1063d7d30>, '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 0x10613cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:37:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:37:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:37:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:55 INFO - Return code: 0 03:37:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:37:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:37:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NTBY49BSgy/Render', 03:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:55 INFO - 'HOME': '/Users/cltbld', 03:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:55 INFO - 'LOGNAME': 'cltbld', 03:37:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:55 INFO - 'MOZ_NO_REMOTE': '1', 03:37:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:55 INFO - 'NO_EM_RESTART': '1', 03:37:55 INFO - 'PAGER': '/bin/cat', 03:37:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:55 INFO - 'PWD': '/builds/slave/test', 03:37:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:55 INFO - 'SHELL': '/bin/bash', 03:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D8cwzTVtJF/Listeners', 03:37:55 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:55 INFO - 'USER': 'cltbld', 03:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:55 INFO - 'XPC_FLAGS': '0x0', 03:37:55 INFO - 'XPC_SERVICE_NAME': '0', 03:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:37:55 INFO - mozversion application_buildid: 20160807001853 03:37:55 INFO - mozversion application_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 03:37:55 INFO - mozversion application_display_name: Nightly 03:37:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:55 INFO - mozversion application_name: Firefox 03:37:55 INFO - mozversion application_remotingname: firefox 03:37:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:37:55 INFO - mozversion application_vendor: Mozilla 03:37:55 INFO - mozversion application_version: 51.0a1 03:37:55 INFO - mozversion platform_buildid: 20160807001853 03:37:55 INFO - mozversion platform_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 03:37:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:37:55 INFO - mozversion platform_version: 51.0a1 03:37:55 INFO - using testdate: 1470566275 03:37:55 INFO - actual date: 1470566275 03:37:55 INFO - starting webserver on 'localhost:49660' 03:37:55 INFO - SUITE-START | Running 2 tests 03:37:55 INFO - TEST-START | dromaeo_css 03:37:55 INFO - operating with platform_type : mac_ 03:37:55 INFO - Initialising browser for dromaeo_css test... 03:37:55 INFO - TEST-INFO | started process 2188 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmptxFX3f/profile http://localhost:49660/getInfo.html) 03:37:58 INFO - PROCESS | 2188 | __metrics Screen width/height:1600/1200 03:37:58 INFO - PROCESS | 2188 | colorDepth:24 03:37:58 INFO - PROCESS | 2188 | Browser inner width/height: 1024/689 03:37:58 INFO - PROCESS | 2188 | __metrics 03:37:58 ERROR - PROCESS | 2188 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:37:59 INFO - TEST-INFO | 2188: exit 0 03:37:59 INFO - Browser initialized. 03:37:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:59 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmptxFX3f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:11 INFO - PROCESS | 2191 | RSS: Main: 254455808 03:38:11 INFO - PROCESS | 2191 | 03:39:01 INFO - PROCESS | 2191 | 1470566341197 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:41:13 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49660/tests/dromaeo/cssquery-ext.html) 03:41:15 INFO - PROCESS | 2191 | RSS: Main: 269877248 03:41:15 INFO - PROCESS | 2191 | 03:44:17 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-ext.html (next: http://localhost:49660/tests/dromaeo/cssquery-jquery.html) 03:44:18 INFO - PROCESS | 2191 | RSS: Main: 281149440 03:44:18 INFO - PROCESS | 2191 | 03:47:20 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49660/tests/dromaeo/cssquery-mootools.html) 03:47:20 INFO - PROCESS | 2191 | RSS: Main: 288055296 03:47:20 INFO - PROCESS | 2191 | 03:50:22 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49660/tests/dromaeo/cssquery-prototype.html) 03:50:23 INFO - PROCESS | 2191 | RSS: Main: 287399936 03:50:23 INFO - PROCESS | 2191 | 03:53:25 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49660/tests/dromaeo/cssquery-yui.html) 03:53:26 INFO - PROCESS | 2191 | RSS: Main: 292376576 03:53:26 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-yui.html (next: http://localhost:49660/tests/dromaeo/cssquery-dojo.html) 03:56:29 INFO - PROCESS | 2191 | RSS: Main: 292712448 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | __start_tp_report 03:56:29 INFO - PROCESS | 2191 | _x_x_mozilla_page_load 03:56:29 INFO - PROCESS | 2191 | _x_x_mozilla_page_load_details 03:56:29 INFO - PROCESS | 2191 | |i|pagename|runs| 03:56:29 INFO - PROCESS | 2191 | |0;dojo.html;3254.7721659483846;3305.289362786999;3421.982890085549;3440.4323286657705;3443.6384179661136;4870.65905386623;5327.854511280074;5813.157092221625;5814.040683287252;5896.439838215368;5485.409231322911;5808.1287806829;5820.883582328362;5828.038373668351;5894.793682221123;4482.372467854503;4583.495815460296;5151.304573882516;5317.441668624797;5324.492465623472;5355.705436201008;5376.086065368897;5398.433164517728;5400.189971504286;5444.891102177954;5247.212918062283;5262.9473705263035;5264.289320941701;5325.360956685184;5392.649477783932;5331.466853314676;5339.70631615261;5343.305370301836;5344.198370244456;5352.143657014859;5155.659528522611;5334.986352593034;5338.786448542092;5348.839534813962;5384.623076384654;5491.615586908918;5730.9426905730825;5813.215215945836;5824.708764561798;5882.705864706748;6218.533609979225;6237.844053898689;6270.843228919268;6290.339514351019;6315.968420157916;6277.623342599459;6299.842503937392;6309.432151106376;6324.177856878622;6345.555811093225;5800.129980502916;5832.387599302055;5891.293044834561;5944.286685597756;6016.578839481194;6278.932581461163;6296.622202667763;6313.989761638116;6320.051992201206;6343.175387199634;6145.416185462464;6193.938060619426;6231.657258850716;6271.874562508724;6290.402411770874;6175.938240617626;6235.812925612239;6244.1570387997035;6249.6875156242;6313.684315784192;6287.025511045796;6291.5281353898645;6294.181756371642;6305.464035557029;6305.896468118061;6228.252609686867;6303.6532990685955;6306;6307.24313082433;6337.461315788118;4949.554540091337;5012.874678133003;5027.271045698353;5046.167382381939;5092.796288148506;4451.6661250405705;4510.188166130062;4512.323151527232;4522.954770452319;4558.658100642465;5749.9712501437225;5797.536197104221;5849;5855.443732845458;5862.179294898718;6183.319834818167;6207.596506227171;6218.595791273553;6219.222597175353;6290.182276304143;5825.533957283407;5833.970830145822;5855;5871.148683440877;5918.970405148033;5503.091989821714;5529.972350138223;5530.695811730394;5534.446555344433;5548.889022219614;6177.1969643945995;6211.409916057967;6224.470919971853;6227.906581401373;6385.361463853577;6278.4035516625845;6281.780137695158;6286.717097730521;6291.559590828598;6293.716782744696;6133.793750436688;6311.558190926591;6358.427741503287;6373.80878573625;6375;6162.845928851814;6169.951108311688;6184.536159788124;6264.68676566179;6308.0853276273765;5062.341895553554;6232.719527621177;6283.214598175228;6283.96858015707;6293.150424692791;5651.039323315129;5856.912146317723;6072;6119.3268740437625;6211.720472578835;5142.845714628567;6098.099428985257;6126.08108783686;6208.596441231305;6243.469305109116;4988.376452943382;5874.236349274567;6082.148499210202;6096.8780624388155;6115.205023346936;5134.589232861437;5704.771809127588;5969.582129251085;6062.636241825505;6237.594556353823;5996.610220335664;6016.969915150396;6094.329623741473;6101.762223876893;6124.197855633957 03:56:29 INFO - PROCESS | 2191 | |1;ext.html;492.8890999525107;510.93357863477763;513.3070355020723;513.3557385481221;560.2744445942509;30377.69622303776;41724.58275417245;42043.78978105113;42092.57907420925;42135.57864421355;42115.78942105293;42307.15385692292;42907;43046;43081.569184308144;9659;9796.265280103986;9856.655017074403;9859.654912078078;9881.505924703772;9605;9613.471259080748;9683.903160968406;9707.660231891885;9734.51327433629;9440.05599440054;9732;9763.609455621767;9776.706698799047;9779.511024448784;8640.783980400509;9733.659321923735;9738.977407372195;9765.609375624967;9770.413775173512;8257.710980115668;9569.138777509988;9686.660966866197;9772.267079969031;9774.609015639366;40336;40338.193236135114;40482.19035619301;40491.39262911059;40697;3444.156181735466;3454.758166928316;3479.1302174456387;3591.28174365128;3642.2715456908722;31811;32528.83735581307;32946.84686035977;33268.6673133268;33546.6645333546;3232.337370838972;3237.6600456951915;3251.4147453458368;3352.2122301259183;3358.8320583970703;511681;517790;519451;519523;520448;33704.66295337015;59982;60028;60396.67818270037;61196;34669;35235.64764352375;35567.39946702404;35826.10434739153;35885;14912.328945197492;15010.624734381729;15026.323815428332;15046.623834404008;15048.021878577858;12407.813882791765;12640.178388404724;12709.93645031769;12714.110012299236;12770.80843787344;7677.232276772278;7782.143964163937;7815.80460488481;7883.5269883806;7890.368770498461;3222.3555288942307;3238.951415728766;3243.2702641905385;3243.8053716777067;3265.673432656763;859.875318078875;909.5225006871445;987.5062468765617;991.4794732765356;1033.5194134727387;27809.887604495998;29962.101136965925;30651.38697226043;31133.168890605924;31135;940.1303793990531;962.6678795815433;987.693814917378;1058.666520046183;1163.4938801621322;13991;14752.63118422048;15262.31319590621;16122.193890305673;16400.917995409945;681033;699886;705137;708632;708900.4659720433;60517.69741151266;60548.091778623355;60569.39430605726;61109.69445152835;61143.38856611377;1218.4395178217942;1354.0927578522217;1388.7986241995056;1413;1419.524459306144;27405.31486712848;27430.314242144104;28903;30929.845350773103;30932.53601195939;51407.48592514027;51608.48391516037;51632.709182270744;51766.223506646675;51822;598937;600893;601545;602005;603220;26680.733192667823;26969.865150674123;27211.183664490098;27313.86343068272;27346.5898011526;47598;48140.148788096165;49540;49544.75227623983;49574;39992;40218.798906005286;40800.29361292672;41044;41494.58505415028;38700;40109.398359025225;40229.99425014398;40341;42086.36870447007;39217.80391098026;39318.41022384609;39609.2078158441;39911.80264592067;39930.80034599808;32667.019989400356;33457.49813752844;35086.82456587701;36136.37386317675;36275.63724362723;26025.869870651284;26140.60789088203;26282.342941426617;26340.551269680353;26767.598486022336 03:56:29 INFO - PROCESS | 2191 | |2;jquery.html;359.8920323902829;371.9070232441888;385.46035550229686;391.6729530841747;404.9655779258763;19064.33274835381;20964.790352096476;21179.788202117976;21210.89394553027;21240.681389779165;17290.82709172908;17796.288148474046;20776.857272849986;21302.254421095266;21557.892210538965;5341.30563026806;5925.407459254083;6099.390060993887;6175.6294622322575;6202.78290259841;6066.150738896558;6086.482648974842;6130.662813545253;6143.754249830002;6149.262088549381;5885.440883116097;5937.88124237515;5961.225040744719;6045.7883974060915;6047.5766696331275;5792.594518383715;5970.014947533695;6053.334133245339;6064.241969753781;6066.332703402644;4497.347884556721;5175.870603234949;5246.422893481714;5258.579313654898;5270.9736451317885;23132;24250.908709107956;24312.149074782476;25808.741912580823;26764.86617566919;2146.1308170191096;2314.849534780234;2327.418145463634;2756.0629386008854;2799.048323569996;10119.848202276971;10196.133328667072;10257.076863082359;10258.281920265585;10369.740756481073;1888.0935018032692;1893.8295553400121;1912.6365990461907;1916.0611300462813;1972.4279958811928;105819;134647.92112473282;136222;138563;163776;9626.278029147841;9906;10224.64213752515;10274.743131421774;10379.429131397847;12376.381180941096;12499;12590.559330423392;12593.370331483573;12634.684132896567;7968.362530997506;8214.712485062993;8237.79405514867;8243.670253189925;8289.751307460785;7220.602866842374;8358.247757701836;8794.736157915273;8918.331125165638;8982.550872456482;3671.6695497405362;3877.758377477253;3887.4363217333894;3902.453656488094;4000.4799376080923;1736.2187015842921;1754.9996501993996;1959.3730006397816;2042.77529471758;2045.1819272290904;763.5113527342505;777.9922200778033;818.5375262976519;948.0093302498905;988.8961659025842;17109.80231383791;20189;22103.226387076375;22387.552248955257;22563.77436225617;917.1470532404794;964.7202311329776;977.6969139566758;985.4235272365603;1036.7459972306683;9653.951730241444;11133.610323638633;11687.298762074302;11801.763964720658;11826.940865295619;586563;589269;590060;601505;623882.8805855942;139683;141646;143263;143869;144853;920.5593246569098;975.9512024398751;987.2052997337213;989.9158571521357;990.5740531571349;19161.52096197606;19724.40826775199;19759;19813.306534271233;19816;45827.08345833131;55201.44798551963;55239.723801382344;56274.43725562692;56455.71772141277;64475;75085;76661.61669191618;82651.17348826675;82740;8286.544240066612;8492.957535212285;8596.312295016258;8600.494913390257;8778.297736180963;11011.394373309224;13301;13746.037777355888;13758.380872860946;13852.099613525088;10954.726131846768;11565;11762.764744704888;11825.645230643095;11901.869322414357;9621.374610650286;9756.609735610497;11154.776904462027;11625.011873990805;11648.009919156966;9402.764930876509;11486.081113511067;11599.5360185595;11930.880691192977;12008.399580020789;8129.146439623991;8141.982252218472;8368.456050356708;8423.989121305238;8441.620127094418;8232.83534329322;10295.588176473157;11484.827727583926;11780.882191177978;11886.465109070286 03:56:29 INFO - PROCESS | 2191 | |3;mootools.html;1504.4057597249086;1564.1866229560628;1743.5989722363856;1796.721508166233;1822.0798496759135;7730.8453830923345;8195.180481951802;8239.711610093647;8725.563721813907;8826.073262307453;8411.83176336473;8527.658893644262;8600.569971501416;8604.698835540757;8622.137786221374;2247.0562363807157;2261.8303627227942;2281.3840263128945;2287.256641591481;2293.1056887813766;2257.841951063426;2267.183813827029;2336.2173671819874;2343.8124950003958;2347.80043696286;2282.201229569654;2297.0926484038796;2306.8731219782903;2348.4833336665993;2352.6588644646517;2290.3701482092392;2309.4757460076353;2315.270689732729;2316.2819525946925;2317.385892738426;2304.412374844421;2310.1336998625516;2311.641695537194;2315.1086831569796;2315.7568455312285;8603.268722158624;8621.568921553897;8650.65397384104;8682.348823838238;8695.826083478294;5069.44236134025;5134.486551344873;5148.176291793295;5180.740962951837;5229.450907654679;2967.109867039879;3157.5579418881375;3291.4404551226107;3381.814000230011;3555.5555555555557;988.5353883674661;1069.6363236499549;1080.4705694209858;1080.9513571889283;1086.9619563315325;10186.38881667095;10328.27702060856;11105.611303604335;11187.832182517268;11234.775304493864;3894.9805250973563;4483.439570053743;4501.392312037899;4501.816618939812;4688.906221875543;8869.246114080246;8899;8955.701423293716;9629.566669499889;9674.419534827934;5197.506236907488;5211.0359583477175;5211.088059589557;5232.712200828991;5236.764345604457;3909.6481316681634;4326.307790753527;4742.691725037862;4826.0830442215865;4835.008823191238;3849.2109117630816;3888.844446222176;3944.2900277950243;3949.7235193536753;4025.215083058834;1279.194107712154;1279.4945996331396;1282.0833104330447;1284.242297044748;1291.728736965248;825.8265764189588;894.7092195036639;912.1516989199976;918.5085979001202;951.3245595627044;4913.754312284372;5615.494605485526;5617.21359009739;5942.64344139353;5972.492338151305;442.4734665404368;442.7586965104026;443.32835753832967;456.72596442134454;460.19695631123903;3879.9806000969816;3904.6681032112588;4051.736637118578;4054.027033511995;4062.106336605942;9591.280653950982;10354.53404596795;10454.843177352346;10496.475176241158;10527.842082368617;10120.392776433437;10378.584856605803;10431.269811113149;10445.529951152217;10449.791004180026;6845.178578570603;6949.818530849768;7627.313541781266;7868.291853733192;7892.329152022027;4762.809487620457;5645.153227015816;5645.774169033357;5723.742431590672;5741.913871292018;7746.806329841799;7908.762737117896;9581.568829402833;9656.420614763138;9777.853332200166;8229.711960081368;9770;9789.412635241908;9855.556499957376;9889.653862114792;6773.017912402773;7159.890217016371;7342;7361;7444.813879653052;7306.671199796128;7365.895115732468;8047.114817369968;8370.414071014971;8377.581120943807;7172.856542869218;7437.553746775211;7451.44114191427;7527.2096429876265;7536.886946695694;7199.748008819666;7219.783406497813;7289.161746399232;7293.124825021031;7415.480916335805;6725.058491811053;6747.359000894907;6799.626020568916;6840.897386539305;6844.828879278058;4862.343583616308;4907.950920490749;4923.236898280772;4935.62982776286;5007.198848184273;4017.879463616096;4798.640101992295;4900;4923.335349727884;4997.925031124463 03:56:29 INFO - PROCESS | 2191 | |4;prototype.html;294.2364563956532;303.0333236974053;308.62502059997104;309.37351862478494;312.13538498359543;4457.019455719745;4831.6902921498795;5438.864028399292;5586.128646903282;5691.4877661010505;5550.500454959053;5626.352969408519;5643.238162848014;5688.232088668028;5690.857728556778;4298.46269216348;4329.835082458771;4342.782860856961;4347.652187824974;4348.934765978513;3547.982260088696;3968.3452230382095;4200.878556329049;4337.414449049385;4361.563843615645;3735.62643735627;4195.783222865365;4205.852795152155;4207.768572728499;4216.388623649569;3461.307738452307;3905.218956208741;3950.407438884162;4227.196832601796;4233.624072176555;3010.0969709087403;3361.8151001694896;3647.6352364763575;3652.8356223969718;3664.560252769658;5152.510511501401;5521.365043020024;5576.693281869496;5582.720863956786;5597.468240517144;3745.513083299181;3942.48747662802;4687.921777991047;4716.339712440261;4843.612510999147;4875.634327425457;5351.892962140774;5519.034169020405;6002.249718785152;6010.699465026732;3363.747718921091;3612.277544491112;3945.309570825123;3958.3270843956598;3966.8214930328204;5222.321098257202;5544.16837474378;6225.564210505221;6298.417648763985;6298.70876470327;4033.858814941463;4042.8787136385954;4051.39229115635;4054.412110243998;4062.968515742129;3353.983230083834;3749.8312575934146;3890.591487893787;4065.1259979104634;4077.347624380085;4374.168907907551;4739.573438390561;4795.95204047962;4812.727345405158;4819.542143496362;5287.81024269544;5584.91622625661;5956.421548289707;5985.521158307325;6066.757329706762;1319.33373646308;1357.246728065933;1362.9318534073257;1365.6312795545346;1367.712780316125;802.2058162419163;825.5830805443213;843.4306842881031;845.4842546046906;856.3149480415642;3881.835449365179;4107.199096176277;4259.977605374688;4594.059801726898;4601.2622489618625;4345.565443455629;4692.41344831896;5110.744462776846;5131.1277082895995;5199.618394961272;3953.920921581552;4054.8986275342763;4347.500037495665;4608.331791890158;4643.419572553431;2365.2076554354485;2673.4786716590465;2689.3276680829795;2690.9192724217914;2708.266709306046;4917.369207473984;5142.665726727751;5282.735863206824;5286.220352448018;5308.469153084738;4214.557471465513;4726.669133160714;5291.947080529222;5297.490215288624;5319.627626066138;4504.797284122157;5066.923996140061;5151.793928242828;5211.820789318513;5300.31095957523;5130.921976599483;5152.871178220425;5168.147255702767;5174.8965020700125;5175.870603234949;4146.834126634901;4590.724556526486;4842.854714358575;5014.595913144325;5098.1842905135;5233.39815921174;5241.842744717665;5260.8158714446345;5295.788168473218;5352.330958630171;2999.3803346192813;3112.2612101350664;3459.550258466383;3460.100373902753;3517.050396393011;4720.811167553396;4766.8559545708085;4929.334539837076;5086.160783470686;5115.360579927509;5351.652142610717;5678.4605462480995;5881.206037184926;5991.460768530853;6063.878182536245;5140.357455318085;5674.404187560247;5976.671283079472;6002.369751176064;6042.909356359746;4832.371791667061;5677.403872593483;5870.471657550841;5874.500667443315;5903.557233207613;5517.806876759455;5622.88754224905;5955.047192449188;6003.7898673546215;6054.212952316171;4747;5513.61404701667;5910.586258962004;5921.437463440966;5925.703714814156 03:56:29 INFO - PROCESS | 2191 | |5;yui.html;710.0804458226596;756.6557216466508;807.3500831830374;815.865382211935;874.300559552358;15064.472743453982;15148;15557.222138893067;15601.297941592642;15670.608234794136;14344.784828227585;14416.423343066264;14545.92727036366;14586.416543338253;14595.051321664085;691.8892977123661;854.8974123105236;876.544197017552;890.2699786175339;895.7044175422128;847.0978407995465;848.8896443462341;850.698002209213;871.3029576338935;884.3588398411165;843.8143608406141;885.4864178776294;887.7603047177258;893.4237416866117;929.1312622697766;879.160401816264;879.7888506758396;923.1829830599934;927.7680579855037;928.0626567167142;654.3358491131505;654.7741029344868;656.3272645538314;686.2040033561045;692.4391243093111;15300.158491282975;15430.151341676203;15511.379544818306;15534.223288835627;15618.9219053904;14729.484468043674;14746.705065898623;14930;15044.548663540001;15062.849371506254;9960.750981225456;12098.153129280954;12103.273803571814;12160.260313214345;12525.43635536403;3920.627540383659;3951.27097557575;3991.560928297885;4069.226846899109;4078.9796051019853;122689;122887;124161;124301;124539.37730311381;11465.31208127515;11506.367149806842;11506.712332191595;11560.190786645022;11652.53389864413;23774.405639858796;24074.27777166688;24190.879045605012;24236.272911812674;24265.878670606533;8111.229433203836;8230.300424463987;8259.132791056973;8386.87419688705;8415.326773858076;4295.699301048897;4393;4495.77521123949;4600.079984003212;4639.280911458662;3390.7456940729544;3521.7534772566187;3531.858725650945;3533.9646603533633;3535.1869070113503;532.890757394741;636.0872148466965;640.9519286053564;647.0520687193191;647.8833809914261;545.7162275616657;587.529976019183;619.6282230661657;666.7333066773233;698.8043347862607;8858.86711699325;9580.856287155699;9623.663171788954;9628.47043412619;9976.251781116445;648.9513286503532;649.5193556768052;660.1550015979553;669.8459354348527;699.0772180721399;4346.638457221449;4532.773361331921;4913.434954980223;4940.802367905244;5045.268436076748;96938;100395;140112;158626.20686896492;165807;130951;142144;143432;145483;146410;122997;123133;123156.76843231633;127130;128877.06684399741;9230.861537077084;9482.38364506305;9930.354526955725;10063;10166.186705063725;54016;59497.30861692349;59733;65687.68624627385;69611.65194173997;65043.349566505625;67947.62183323757;82843.7573436411;92504;93214;11235.494402751732;14247.21640309793;14305.499307524187;14667.973241872967;15008.849911500745;15175.392984280947;15385;15581.922090389475;15710;16196;13979.580612581232;14267.571972840831;14306.642333941734;14753.557393278219;14793.92603036978;13611.727765444833;14249.64375890611;14446.483119272745;14943.850561494246;14969;13521.526746563823;13915.791263131263;14087.647808804863;14183.361748721127;14469.565913022627;11421.257618254787;11530.884691153316;11709.121815863675;11818.527258909548;11949.522019119138;8848.380613357262;9673;10892.945535272273;11144.777104457704;11607.76784464289 03:56:29 INFO - PROCESS | 2191 | __end_tp_report 03:56:29 INFO - PROCESS | 2191 | __start_cc_report 03:56:29 INFO - PROCESS | 2191 | _x_x_mozilla_cycle_collect,416 03:56:29 INFO - PROCESS | 2191 | __end_cc_report 03:56:29 INFO - PROCESS | 2191 | __startTimestamp1470567389605__endTimestamp 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | ------- Summary: start ------- 03:56:29 INFO - PROCESS | 2191 | Number of tests: 6 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | [#0] dojo.html Cycles:165 Average:5767.71 Median:5969.58 stddev:649.42 (10.9%) stddev-sans-first:620.77 03:56:29 INFO - PROCESS | 2191 | Values: 3254.8 3305.3 3422.0 3440.4 3443.6 4870.7 5327.9 5813.2 5814.0 5896.4 5485.4 5808.1 5820.9 5828.0 5894.8 4482.4 4583.5 5151.3 5317.4 5324.5 5355.7 5376.1 5398.4 5400.2 5444.9 5247.2 5262.9 5264.3 5325.4 5392.6 5331.5 5339.7 5343.3 5344.2 5352.1 5155.7 5335.0 5338.8 5348.8 5384.6 5491.6 5730.9 5813.2 5824.7 5882.7 6218.5 6237.8 6270.8 6290.3 6316.0 6277.6 6299.8 6309.4 6324.2 6345.6 5800.1 5832.4 5891.3 5944.3 6016.6 6278.9 6296.6 6314.0 6320.1 6343.2 6145.4 6193.9 6231.7 6271.9 6290.4 6175.9 6235.8 6244.2 6249.7 6313.7 6287.0 6291.5 6294.2 6305.5 6305.9 6228.3 6303.7 6306.0 6307.2 6337.5 4949.6 5012.9 5027.3 5046.2 5092.8 4451.7 4510.2 4512.3 4523.0 4558.7 5750.0 5797.5 5849.0 5855.4 5862.2 6183.3 6207.6 6218.6 6219.2 6290.2 5825.5 5834.0 5855.0 5871.1 5919.0 5503.1 5530.0 5530.7 5534.4 5548.9 6177.2 6211.4 6224.5 6227.9 6385.4 6278.4 6281.8 6286.7 6291.6 6293.7 6133.8 6311.6 6358.4 6373.8 6375.0 6162.8 6170.0 6184.5 6264.7 6308.1 5062.3 6232.7 6283.2 6284.0 6293.2 5651.0 5856.9 6072.0 6119.3 6211.7 5142.8 6098.1 6126.1 6208.6 6243.5 4988.4 5874.2 6082.1 6096.9 6115.2 5134.6 5704.8 5969.6 6062.6 6237.6 5996.6 6017.0 6094.3 6101.8 6124.2 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | [#1] ext.html Cycles:180 Average:72446.52 Median:40748.65 stddev:163889.09 (402.2%) stddev-sans-first:164259.80 03:56:29 INFO - PROCESS | 2191 | Values: 492.9 510.9 513.3 513.4 560.3 30377.7 41724.6 42043.8 42092.6 42135.6 42115.8 42307.2 42907.0 43046.0 43081.6 9659.0 9796.3 9856.7 9859.7 9881.5 9605.0 9613.5 9683.9 9707.7 9734.5 9440.1 9732.0 9763.6 9776.7 9779.5 8640.8 9733.7 9739.0 9765.6 9770.4 8257.7 9569.1 9686.7 9772.3 9774.6 40336.0 40338.2 40482.2 40491.4 40697.0 3444.2 3454.8 3479.1 3591.3 3642.3 31811.0 32528.8 32946.8 33268.7 33546.7 3232.3 3237.7 3251.4 3352.2 3358.8 511681.0 517790.0 519451.0 519523.0 520448.0 33704.7 59982.0 60028.0 60396.7 61196.0 34669.0 35235.6 35567.4 35826.1 35885.0 14912.3 15010.6 15026.3 15046.6 15048.0 12407.8 12640.2 12709.9 12714.1 12770.8 7677.2 7782.1 7815.8 7883.5 7890.4 3222.4 3239.0 3243.3 3243.8 3265.7 859.9 909.5 987.5 991.5 1033.5 27809.9 29962.1 30651.4 31133.2 31135.0 940.1 962.7 987.7 1058.7 1163.5 13991.0 14752.6 15262.3 16122.2 16400.9 681033.0 699886.0 705137.0 708632.0 708900.5 60517.7 60548.1 60569.4 61109.7 61143.4 1218.4 1354.1 1388.8 1413.0 1419.5 27405.3 27430.3 28903.0 30929.8 30932.5 51407.5 51608.5 51632.7 51766.2 51822.0 598937.0 600893.0 601545.0 602005.0 603220.0 26680.7 26969.9 27211.2 27313.9 27346.6 47598.0 48140.1 49540.0 49544.8 49574.0 39992.0 40218.8 40800.3 41044.0 41494.6 38700.0 40109.4 40230.0 40341.0 42086.4 39217.8 39318.4 39609.2 39911.8 39930.8 32667.0 33457.5 35086.8 36136.4 36275.6 26025.9 26140.6 26282.3 26340.6 26767.6 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | [#2] jquery.html Cycles:180 Average:35840.90 Median:2021.79 stddev:100791.09 (4985.2%) stddev-sans-first:101038.63 03:56:29 INFO - PROCESS | 2191 | Values: 359.9 371.9 385.5 391.7 405.0 19064.3 20964.8 21179.8 21210.9 21240.7 17290.8 17796.3 20776.9 21302.3 21557.9 5341.3 5925.4 6099.4 6175.6 6202.8 6066.2 6086.5 6130.7 6143.8 6149.3 5885.4 5937.9 5961.2 6045.8 6047.6 5792.6 5970.0 6053.3 6064.2 6066.3 4497.3 5175.9 5246.4 5258.6 5271.0 23132.0 24250.9 24312.1 25808.7 26764.9 2146.1 2314.8 2327.4 2756.1 2799.0 10119.8 10196.1 10257.1 10258.3 10369.7 1888.1 1893.8 1912.6 1916.1 1972.4 105819.0 134647.9 136222.0 138563.0 163776.0 9626.3 9906.0 10224.6 10274.7 10379.4 12376.4 12499.0 12590.6 12593.4 12634.7 7968.4 8214.7 8237.8 8243.7 8289.8 7220.6 8358.2 8794.7 8918.3 8982.6 3671.7 3877.8 3887.4 3902.5 4000.5 1736.2 1755.0 1959.4 2042.8 2045.2 763.5 778.0 818.5 948.0 988.9 17109.8 20189.0 22103.2 22387.6 22563.8 917.1 964.7 977.7 985.4 1036.7 9654.0 11133.6 11687.3 11801.8 11826.9 586563.0 589269.0 590060.0 601505.0 623882.9 139683.0 141646.0 143263.0 143869.0 144853.0 920.6 976.0 987.2 989.9 990.6 19161.5 19724.4 19759.0 19813.3 19816.0 45827.1 55201.4 55239.7 56274.4 56455.7 64475.0 75085.0 76661.6 82651.2 82740.0 8286.5 8493.0 8596.3 8600.5 8778.3 11011.4 13301.0 13746.0 13758.4 13852.1 10954.7 11565.0 11762.8 11825.6 11901.9 9621.4 9756.6 11154.8 11625.0 11648.0 9402.8 11486.1 11599.5 11930.9 12008.4 8129.1 8142.0 8368.5 8424.0 8441.6 8232.8 10295.6 11484.8 11780.9 11886.5 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | [#3] mootools.html Cycles:180 Average:5468.87 Median:4923.29 stddev:3037.95 (61.7%) stddev-sans-first:3031.87 03:56:29 INFO - PROCESS | 2191 | Values: 1504.4 1564.2 1743.6 1796.7 1822.1 7730.8 8195.2 8239.7 8725.6 8826.1 8411.8 8527.7 8600.6 8604.7 8622.1 2247.1 2261.8 2281.4 2287.3 2293.1 2257.8 2267.2 2336.2 2343.8 2347.8 2282.2 2297.1 2306.9 2348.5 2352.7 2290.4 2309.5 2315.3 2316.3 2317.4 2304.4 2310.1 2311.6 2315.1 2315.8 8603.3 8621.6 8650.7 8682.3 8695.8 5069.4 5134.5 5148.2 5180.7 5229.5 2967.1 3157.6 3291.4 3381.8 3555.6 988.5 1069.6 1080.5 1081.0 1087.0 10186.4 10328.3 11105.6 11187.8 11234.8 3895.0 4483.4 4501.4 4501.8 4688.9 8869.2 8899.0 8955.7 9629.6 9674.4 5197.5 5211.0 5211.1 5232.7 5236.8 3909.6 4326.3 4742.7 4826.1 4835.0 3849.2 3888.8 3944.3 3949.7 4025.2 1279.2 1279.5 1282.1 1284.2 1291.7 825.8 894.7 912.2 918.5 951.3 4913.8 5615.5 5617.2 5942.6 5972.5 442.5 442.8 443.3 456.7 460.2 3880.0 3904.7 4051.7 4054.0 4062.1 9591.3 10354.5 10454.8 10496.5 10527.8 10120.4 10378.6 10431.3 10445.5 10449.8 6845.2 6949.8 7627.3 7868.3 7892.3 4762.8 5645.2 5645.8 5723.7 5741.9 7746.8 7908.8 9581.6 9656.4 9777.9 8229.7 9770.0 9789.4 9855.6 9889.7 6773.0 7159.9 7342.0 7361.0 7444.8 7306.7 7365.9 8047.1 8370.4 8377.6 7172.9 7437.6 7451.4 7527.2 7536.9 7199.7 7219.8 7289.2 7293.1 7415.5 6725.1 6747.4 6799.6 6840.9 6844.8 4862.3 4908.0 4923.2 4935.6 5007.2 4017.9 4798.6 4900.0 4923.3 4997.9 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | [#4] prototype.html Cycles:180 Average:4448.16 Median:4832.03 stddev:1388.38 (28.7%) stddev-sans-first:1356.82 03:56:29 INFO - PROCESS | 2191 | Values: 294.2 303.0 308.6 309.4 312.1 4457.0 4831.7 5438.9 5586.1 5691.5 5550.5 5626.4 5643.2 5688.2 5690.9 4298.5 4329.8 4342.8 4347.7 4348.9 3548.0 3968.3 4200.9 4337.4 4361.6 3735.6 4195.8 4205.9 4207.8 4216.4 3461.3 3905.2 3950.4 4227.2 4233.6 3010.1 3361.8 3647.6 3652.8 3664.6 5152.5 5521.4 5576.7 5582.7 5597.5 3745.5 3942.5 4687.9 4716.3 4843.6 4875.6 5351.9 5519.0 6002.2 6010.7 3363.7 3612.3 3945.3 3958.3 3966.8 5222.3 5544.2 6225.6 6298.4 6298.7 4033.9 4042.9 4051.4 4054.4 4063.0 3354.0 3749.8 3890.6 4065.1 4077.3 4374.2 4739.6 4796.0 4812.7 4819.5 5287.8 5584.9 5956.4 5985.5 6066.8 1319.3 1357.2 1362.9 1365.6 1367.7 802.2 825.6 843.4 845.5 856.3 3881.8 4107.2 4260.0 4594.1 4601.3 4345.6 4692.4 5110.7 5131.1 5199.6 3953.9 4054.9 4347.5 4608.3 4643.4 2365.2 2673.5 2689.3 2690.9 2708.3 4917.4 5142.7 5282.7 5286.2 5308.5 4214.6 4726.7 5291.9 5297.5 5319.6 4504.8 5066.9 5151.8 5211.8 5300.3 5130.9 5152.9 5168.1 5174.9 5175.9 4146.8 4590.7 4842.9 5014.6 5098.2 5233.4 5241.8 5260.8 5295.8 5352.3 2999.4 3112.3 3459.6 3460.1 3517.1 4720.8 4766.9 4929.3 5086.2 5115.4 5351.7 5678.5 5881.2 5991.5 6063.9 5140.4 5674.4 5976.7 6002.4 6042.9 4832.4 5677.4 5870.5 5874.5 5903.6 5517.8 5622.9 5955.0 6003.8 6054.2 4747.0 5513.6 5910.6 5921.4 5925.7 03:56:29 INFO - PROCESS | 2191 | 03:56:29 INFO - PROCESS | 2191 | [#5] yui.html Cycles:180 Average:25507.87 Median:3532.91 stddev:40873.42 (1156.9%) stddev-sans-first:40945.68 03:56:29 INFO - PROCESS | 2191 | Values: 710.1 756.7 807.4 815.9 874.3 15064.5 15148.0 15557.2 15601.3 15670.6 14344.8 14416.4 14545.9 14586.4 14595.1 691.9 854.9 876.5 890.3 895.7 847.1 848.9 850.7 871.3 884.4 843.8 885.5 887.8 893.4 929.1 879.2 879.8 923.2 927.8 928.1 654.3 654.8 656.3 686.2 692.4 15300.2 15430.2 15511.4 15534.2 15618.9 14729.5 14746.7 14930.0 15044.5 15062.8 9960.8 12098.2 12103.3 12160.3 12525.4 3920.6 3951.3 3991.6 4069.2 4079.0 122689.0 122887.0 124161.0 124301.0 124539.4 11465.3 11506.4 11506.7 11560.2 11652.5 23774.4 24074.3 24190.9 24236.3 24265.9 8111.2 8230.3 8259.1 8386.9 8415.3 4295.7 4393.0 4495.8 4600.1 4639.3 3390.7 3521.8 3531.9 3534.0 3535.2 532.9 636.1 641.0 647.1 647.9 545.7 587.5 619.6 666.7 698.8 8858.9 9580.9 9623.7 9628.5 9976.3 649.0 649.5 660.2 669.8 699.1 4346.6 4532.8 4913.4 4940.8 5045.3 96938.0 100395.0 140112.0 158626.2 165807.0 130951.0 142144.0 143432.0 145483.0 146410.0 122997.0 123133.0 123156.8 127130.0 128877.1 9230.9 9482.4 9930.4 10063.0 10166.2 54016.0 59497.3 59733.0 65687.7 69611.7 65043.3 67947.6 82843.8 92504.0 93214.0 11235.5 14247.2 14305.5 14668.0 15008.8 15175.4 15385.0 15581.9 15710.0 16196.0 13979.6 14267.6 14306.6 14753.6 14793.9 13611.7 14249.6 14446.5 14943.9 14969.0 13521.5 13915.8 14087.6 14183.4 14469.6 11421.3 11530.9 11709.1 11818.5 11949.5 8848.4 9673.0 10892.9 11144.8 11607.8 03:56:29 INFO - PROCESS | 2191 | -------- Summary: end -------- 03:56:29 INFO - PROCESS | 2191 | 03:56:30 INFO - TEST-INFO | 2191: exit 0 03:56:30 INFO - TEST-OK | dromaeo_css | took 1114499ms 03:56:30 INFO - TEST-START | kraken 03:56:30 INFO - operating with platform_type : mac_ 03:56:30 INFO - Initialising browser for kraken test... 03:56:30 INFO - TEST-INFO | started process 2310 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp7mDZrp/profile http://localhost:49660/getInfo.html) 03:56:33 INFO - PROCESS | 2310 | __metrics Screen width/height:1600/1200 03:56:33 INFO - PROCESS | 2310 | colorDepth:24 03:56:33 INFO - PROCESS | 2310 | Browser inner width/height: 1024/689 03:56:33 INFO - PROCESS | 2310 | __metrics 03:56:33 ERROR - PROCESS | 2310 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:56:33 INFO - TEST-INFO | 2310: exit 0 03:56:33 INFO - Browser initialized. 03:56:33 INFO - Running cycle 1/1 for kraken test... 03:56:33 INFO - TEST-INFO | started process 2312 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp7mDZrp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:46 INFO - PROCESS | 2312 | RSS: Main: 254676992 03:56:46 INFO - PROCESS | 2312 | 03:56:48 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:49 INFO - PROCESS | 2312 | RSS: Main: 267526144 03:56:49 INFO - PROCESS | 2312 | 03:56:52 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-dft) 03:56:52 INFO - PROCESS | 2312 | RSS: Main: 276160512 03:56:52 INFO - PROCESS | 2312 | 03:56:56 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-fft) 03:56:56 INFO - PROCESS | 2312 | RSS: Main: 278941696 03:56:56 INFO - PROCESS | 2312 | 03:56:58 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-oscillator) 03:56:59 INFO - PROCESS | 2312 | RSS: Main: 281260032 03:56:59 INFO - PROCESS | 2312 | 03:57:01 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:02 INFO - PROCESS | 2312 | RSS: Main: 281915392 03:57:02 INFO - PROCESS | 2312 | 03:57:05 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:06 INFO - PROCESS | 2312 | RSS: Main: 282136576 03:57:06 INFO - PROCESS | 2312 | 03:57:09 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:09 INFO - PROCESS | 2312 | RSS: Main: 282144768 03:57:09 INFO - PROCESS | 2312 | 03:57:12 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49660/tests/kraken/driver.html?testName=json-parse-financial) 03:57:13 INFO - PROCESS | 2312 | RSS: Main: 282333184 03:57:13 INFO - PROCESS | 2312 | 03:57:15 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:15 INFO - PROCESS | 2312 | RSS: Main: 282095616 03:57:15 INFO - PROCESS | 2312 | 03:57:17 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:18 INFO - PROCESS | 2312 | RSS: Main: 282161152 03:57:18 INFO - PROCESS | 2312 | 03:57:20 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:21 INFO - PROCESS | 2312 | RSS: Main: 282566656 03:57:21 INFO - PROCESS | 2312 | 03:57:24 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:24 INFO - PROCESS | 2312 | RSS: Main: 282599424 03:57:24 INFO - PROCESS | 2312 | 03:57:27 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:28 INFO - PROCESS | 2312 | RSS: Main: 282603520 03:57:28 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49660/tests/kraken/driver.html?testName=ai-astar) 03:57:30 INFO - PROCESS | 2312 | RSS: Main: 284004352 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | __start_tp_report 03:57:30 INFO - PROCESS | 2312 | _x_x_mozilla_page_load 03:57:30 INFO - PROCESS | 2312 | _x_x_mozilla_page_load_details 03:57:30 INFO - PROCESS | 2312 | |i|pagename|runs| 03:57:30 INFO - PROCESS | 2312 | |0;ai-astar;104;117;107;119;117;117;114;117;115;118 03:57:30 INFO - PROCESS | 2312 | |1;audio-beat-detection;147;110;133;156;110;129;132;110;182;138 03:57:30 INFO - PROCESS | 2312 | |2;audio-dft;193;203;218;236;200;201;203;200;198;202 03:57:30 INFO - PROCESS | 2312 | |3;audio-fft;69;87;76;144;60;60;59;62;138;59 03:57:30 INFO - PROCESS | 2312 | |4;audio-oscillator;69;104;106;102;105;132;153;82;71;116 03:57:30 INFO - PROCESS | 2312 | |5;imaging-gaussian-blur;134;130;88;86;88;106;81;131;133;116 03:57:30 INFO - PROCESS | 2312 | |6;imaging-darkroom;95;93;94;138;149;96;96;94;94;93 03:57:30 INFO - PROCESS | 2312 | |7;imaging-desaturate;92;79;145;133;90;82;152;143;90;90 03:57:30 INFO - PROCESS | 2312 | |8;json-parse-financial;55;55;70;74;56;58;57;57;58;54 03:57:30 INFO - PROCESS | 2312 | |9;json-stringify-tinderbox;67;73;62;98;117;114;114;107;72;73 03:57:30 INFO - PROCESS | 2312 | |10;stanford-crypto-aes;88;85;88;86;87;85;86;98;109;103 03:57:30 INFO - PROCESS | 2312 | |11;stanford-crypto-ccm;139;135;141;137;133;138;137;142;138;138 03:57:30 INFO - PROCESS | 2312 | |12;stanford-crypto-pbkdf2;168;169;173;169;193;171;168;168;169;168 03:57:30 INFO - PROCESS | 2312 | |13;stanford-crypto-sha256-iterative;66;72;69;68;71;68;70;68;69;70 03:57:30 INFO - PROCESS | 2312 | __end_tp_report 03:57:30 INFO - PROCESS | 2312 | __start_cc_report 03:57:30 INFO - PROCESS | 2312 | _x_x_mozilla_cycle_collect,1054 03:57:30 INFO - PROCESS | 2312 | __end_cc_report 03:57:30 INFO - PROCESS | 2312 | __startTimestamp1470567450332__endTimestamp 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | ------- Summary: start ------- 03:57:30 INFO - PROCESS | 2312 | Number of tests: 14 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#0] ai-astar Cycles:10 Average:114.50 Median:117.00 stddev:4.99 (4.3%) stddev-sans-first:3.57 03:57:30 INFO - PROCESS | 2312 | Values: 104.0 117.0 107.0 119.0 117.0 117.0 114.0 117.0 115.0 118.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:135.50 stddev:22.92 (16.9%) stddev-sans-first:23.87 03:57:30 INFO - PROCESS | 2312 | Values: 147.0 110.0 133.0 156.0 110.0 129.0 132.0 110.0 182.0 138.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#2] audio-dft Cycles:10 Average:205.40 Median:202.50 stddev:12.49 (6.2%) stddev-sans-first:12.42 03:57:30 INFO - PROCESS | 2312 | Values: 193.0 203.0 218.0 236.0 200.0 201.0 203.0 200.0 198.0 202.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#3] audio-fft Cycles:10 Average:81.40 Median:61.00 stddev:32.71 (53.6%) stddev-sans-first:34.39 03:57:30 INFO - PROCESS | 2312 | Values: 69.0 87.0 76.0 144.0 60.0 60.0 59.0 62.0 138.0 59.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:142.50 stddev:26.11 (18.3%) stddev-sans-first:24.43 03:57:30 INFO - PROCESS | 2312 | Values: 69.0 104.0 106.0 102.0 105.0 132.0 153.0 82.0 71.0 116.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:107.50 stddev:22.06 (20.5%) stddev-sans-first:21.51 03:57:30 INFO - PROCESS | 2312 | Values: 134.0 130.0 88.0 86.0 88.0 106.0 81.0 131.0 133.0 116.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:94.00 stddev:20.90 (22.2%) stddev-sans-first:21.90 03:57:30 INFO - PROCESS | 2312 | Values: 95.0 93.0 94.0 138.0 149.0 96.0 96.0 94.0 94.0 93.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#7] imaging-desaturate Cycles:10 Average:109.60 Median:86.00 stddev:29.58 (34.4%) stddev-sans-first:30.68 03:57:30 INFO - PROCESS | 2312 | Values: 92.0 79.0 145.0 133.0 90.0 82.0 152.0 143.0 90.0 90.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:57.50 stddev:6.83 (11.9%) stddev-sans-first:7.06 03:57:30 INFO - PROCESS | 2312 | Values: 55.0 55.0 70.0 74.0 56.0 58.0 57.0 57.0 58.0 54.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#9] json-stringify-tinderbox Cycles:10 Average:89.70 Median:69.50 stddev:22.23 (32.0%) stddev-sans-first:22.01 03:57:30 INFO - PROCESS | 2312 | Values: 67.0 73.0 62.0 98.0 117.0 114.0 114.0 107.0 72.0 73.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:86.50 stddev:8.63 (10.0%) stddev-sans-first:9.06 03:57:30 INFO - PROCESS | 2312 | Values: 88.0 85.0 88.0 86.0 87.0 85.0 86.0 98.0 109.0 103.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:138.00 stddev:2.62 (1.9%) stddev-sans-first:2.74 03:57:30 INFO - PROCESS | 2312 | Values: 139.0 135.0 141.0 137.0 133.0 138.0 137.0 142.0 138.0 138.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:169.00 stddev:7.69 (4.6%) stddev-sans-first:8.05 03:57:30 INFO - PROCESS | 2312 | Values: 168.0 169.0 173.0 169.0 193.0 171.0 168.0 168.0 169.0 168.0 03:57:30 INFO - PROCESS | 2312 | 03:57:30 INFO - PROCESS | 2312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.73 (2.5%) stddev-sans-first:1.42 03:57:30 INFO - PROCESS | 2312 | Values: 66.0 72.0 69.0 68.0 71.0 68.0 70.0 68.0 69.0 70.0 03:57:30 INFO - PROCESS | 2312 | -------- Summary: end -------- 03:57:30 INFO - PROCESS | 2312 | 03:57:31 INFO - TEST-INFO | 2312: exit 0 03:57:31 INFO - TEST-OK | kraken | took 61064ms 03:57:31 INFO - SUITE-END | took 1175s 03:57:31 INFO - Completed test suite (00:19:35) 03:57:31 INFO - javascript benchmark 03:57:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7253.065233004422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.7721659483846, 3305.289362786999, 3421.982890085549, 3440.4323286657705, 3443.6384179661136, 4870.65905386623, 5327.854511280074, 5813.157092221625, 5814.040683287252, 5896.439838215368, 5485.409231322911, 5808.1287806829, 5820.883582328362, 5828.038373668351, 5894.793682221123, 4482.372467854503, 4583.495815460296, 5151.304573882516, 5317.441668624797, 5324.492465623472, 5355.705436201008, 5376.086065368897, 5398.433164517728, 5400.189971504286, 5444.891102177954, 5247.212918062283, 5262.9473705263035, 5264.289320941701, 5325.360956685184, 5392.649477783932, 5331.466853314676, 5339.70631615261, 5343.305370301836, 5344.198370244456, 5352.143657014859, 5155.659528522611, 5334.986352593034, 5338.786448542092, 5348.839534813962, 5384.623076384654, 5491.615586908918, 5730.9426905730825, 5813.215215945836, 5824.708764561798, 5882.705864706748, 6218.533609979225, 6237.844053898689, 6270.843228919268, 6290.339514351019, 6315.968420157916, 6277.623342599459, 6299.842503937392, 6309.432151106376, 6324.177856878622, 6345.555811093225, 5800.129980502916, 5832.387599302055, 5891.293044834561, 5944.286685597756, 6016.578839481194, 6278.932581461163, 6296.622202667763, 6313.989761638116, 6320.051992201206, 6343.175387199634, 6145.416185462464, 6193.938060619426, 6231.657258850716, 6271.874562508724, 6290.402411770874, 6175.938240617626, 6235.812925612239, 6244.1570387997035, 6249.6875156242, 6313.684315784192, 6287.025511045796, 6291.5281353898645, 6294.181756371642, 6305.464035557029, 6305.896468118061, 6228.252609686867, 6303.6532990685955, 6306.0, 6307.24313082433, 6337.461315788118, 4949.554540091337, 5012.874678133003, 5027.271045698353, 5046.167382381939, 5092.796288148506, 4451.6661250405705, 4510.188166130062, 4512.323151527232, 4522.954770452319, 4558.658100642465, 5749.9712501437225, 5797.536197104221, 5849.0, 5855.443732845458, 5862.179294898718, 6183.319834818167, 6207.596506227171, 6218.595791273553, 6219.222597175353, 6290.182276304143, 5825.533957283407, 5833.970830145822, 5855.0, 5871.148683440877, 5918.970405148033, 5503.091989821714, 5529.972350138223, 5530.695811730394, 5534.446555344433, 5548.889022219614, 6177.1969643945995, 6211.409916057967, 6224.470919971853, 6227.906581401373, 6385.361463853577, 6278.4035516625845, 6281.780137695158, 6286.717097730521, 6291.559590828598, 6293.716782744696, 6133.793750436688, 6311.558190926591, 6358.427741503287, 6373.80878573625, 6375.0, 6162.845928851814, 6169.951108311688, 6184.536159788124, 6264.68676566179, 6308.0853276273765, 5062.341895553554, 6232.719527621177, 6283.214598175228, 6283.96858015707, 6293.150424692791, 5651.039323315129, 5856.912146317723, 6072.0, 6119.3268740437625, 6211.720472578835, 5142.845714628567, 6098.099428985257, 6126.08108783686, 6208.596441231305, 6243.469305109116, 4988.376452943382, 5874.236349274567, 6082.148499210202, 6096.8780624388155, 6115.205023346936, 5134.589232861437, 5704.771809127588, 5969.582129251085, 6062.636241825505, 6237.594556353823, 5996.610220335664, 6016.969915150396, 6094.329623741473, 6101.762223876893, 6124.197855633957], "value": 5727.762675277489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8890999525107, 510.93357863477763, 513.3070355020723, 513.3557385481221, 560.2744445942509, 30377.69622303776, 41724.58275417245, 42043.78978105113, 42092.57907420925, 42135.57864421355, 42115.78942105293, 42307.15385692292, 42907.0, 43046.0, 43081.569184308144, 9659.0, 9796.265280103986, 9856.655017074403, 9859.654912078078, 9881.505924703772, 9605.0, 9613.471259080748, 9683.903160968406, 9707.660231891885, 9734.51327433629, 9440.05599440054, 9732.0, 9763.609455621767, 9776.706698799047, 9779.511024448784, 8640.783980400509, 9733.659321923735, 9738.977407372195, 9765.609375624967, 9770.413775173512, 8257.710980115668, 9569.138777509988, 9686.660966866197, 9772.267079969031, 9774.609015639366, 40336.0, 40338.193236135114, 40482.19035619301, 40491.39262911059, 40697.0, 3444.156181735466, 3454.758166928316, 3479.1302174456387, 3591.28174365128, 3642.2715456908722, 31811.0, 32528.83735581307, 32946.84686035977, 33268.6673133268, 33546.6645333546, 3232.337370838972, 3237.6600456951915, 3251.4147453458368, 3352.2122301259183, 3358.8320583970703, 511681.0, 517790.0, 519451.0, 519523.0, 520448.0, 33704.66295337015, 59982.0, 60028.0, 60396.67818270037, 61196.0, 34669.0, 35235.64764352375, 35567.39946702404, 35826.10434739153, 35885.0, 14912.328945197492, 15010.624734381729, 15026.323815428332, 15046.623834404008, 15048.021878577858, 12407.813882791765, 12640.178388404724, 12709.93645031769, 12714.110012299236, 12770.80843787344, 7677.232276772278, 7782.143964163937, 7815.80460488481, 7883.5269883806, 7890.368770498461, 3222.3555288942307, 3238.951415728766, 3243.2702641905385, 3243.8053716777067, 3265.673432656763, 859.875318078875, 909.5225006871445, 987.5062468765617, 991.4794732765356, 1033.5194134727387, 27809.887604495998, 29962.101136965925, 30651.38697226043, 31133.168890605924, 31135.0, 940.1303793990531, 962.6678795815433, 987.693814917378, 1058.666520046183, 1163.4938801621322, 13991.0, 14752.63118422048, 15262.31319590621, 16122.193890305673, 16400.917995409945, 681033.0, 699886.0, 705137.0, 708632.0, 708900.4659720433, 60517.69741151266, 60548.091778623355, 60569.39430605726, 61109.69445152835, 61143.38856611377, 1218.4395178217942, 1354.0927578522217, 1388.7986241995056, 1413.0, 1419.524459306144, 27405.31486712848, 27430.314242144104, 28903.0, 30929.845350773103, 30932.53601195939, 51407.48592514027, 51608.48391516037, 51632.709182270744, 51766.223506646675, 51822.0, 598937.0, 600893.0, 601545.0, 602005.0, 603220.0, 26680.733192667823, 26969.865150674123, 27211.183664490098, 27313.86343068272, 27346.5898011526, 47598.0, 48140.148788096165, 49540.0, 49544.75227623983, 49574.0, 39992.0, 40218.798906005286, 40800.29361292672, 41044.0, 41494.58505415028, 38700.0, 40109.398359025225, 40229.99425014398, 40341.0, 42086.36870447007, 39217.80391098026, 39318.41022384609, 39609.2078158441, 39911.80264592067, 39930.80034599808, 32667.019989400356, 33457.49813752844, 35086.82456587701, 36136.37386317675, 36275.63724362723, 26025.869870651284, 26140.60789088203, 26282.342941426617, 26340.551269680353, 26767.598486022336], "value": 18962.046252843567, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.8920323902829, 371.9070232441888, 385.46035550229686, 391.6729530841747, 404.9655779258763, 19064.33274835381, 20964.790352096476, 21179.788202117976, 21210.89394553027, 21240.681389779165, 17290.82709172908, 17796.288148474046, 20776.857272849986, 21302.254421095266, 21557.892210538965, 5341.30563026806, 5925.407459254083, 6099.390060993887, 6175.6294622322575, 6202.78290259841, 6066.150738896558, 6086.482648974842, 6130.662813545253, 6143.754249830002, 6149.262088549381, 5885.440883116097, 5937.88124237515, 5961.225040744719, 6045.7883974060915, 6047.5766696331275, 5792.594518383715, 5970.014947533695, 6053.334133245339, 6064.241969753781, 6066.332703402644, 4497.347884556721, 5175.870603234949, 5246.422893481714, 5258.579313654898, 5270.9736451317885, 23132.0, 24250.908709107956, 24312.149074782476, 25808.741912580823, 26764.86617566919, 2146.1308170191096, 2314.849534780234, 2327.418145463634, 2756.0629386008854, 2799.048323569996, 10119.848202276971, 10196.133328667072, 10257.076863082359, 10258.281920265585, 10369.740756481073, 1888.0935018032692, 1893.8295553400121, 1912.6365990461907, 1916.0611300462813, 1972.4279958811928, 105819.0, 134647.92112473282, 136222.0, 138563.0, 163776.0, 9626.278029147841, 9906.0, 10224.64213752515, 10274.743131421774, 10379.429131397847, 12376.381180941096, 12499.0, 12590.559330423392, 12593.370331483573, 12634.684132896567, 7968.362530997506, 8214.712485062993, 8237.79405514867, 8243.670253189925, 8289.751307460785, 7220.602866842374, 8358.247757701836, 8794.736157915273, 8918.331125165638, 8982.550872456482, 3671.6695497405362, 3877.758377477253, 3887.4363217333894, 3902.453656488094, 4000.4799376080923, 1736.2187015842921, 1754.9996501993996, 1959.3730006397816, 2042.77529471758, 2045.1819272290904, 763.5113527342505, 777.9922200778033, 818.5375262976519, 948.0093302498905, 988.8961659025842, 17109.80231383791, 20189.0, 22103.226387076375, 22387.552248955257, 22563.77436225617, 917.1470532404794, 964.7202311329776, 977.6969139566758, 985.4235272365603, 1036.7459972306683, 9653.951730241444, 11133.610323638633, 11687.298762074302, 11801.763964720658, 11826.940865295619, 586563.0, 589269.0, 590060.0, 601505.0, 623882.8805855942, 139683.0, 141646.0, 143263.0, 143869.0, 144853.0, 920.5593246569098, 975.9512024398751, 987.2052997337213, 989.9158571521357, 990.5740531571349, 19161.52096197606, 19724.40826775199, 19759.0, 19813.306534271233, 19816.0, 45827.08345833131, 55201.44798551963, 55239.723801382344, 56274.43725562692, 56455.71772141277, 64475.0, 75085.0, 76661.61669191618, 82651.17348826675, 82740.0, 8286.544240066612, 8492.957535212285, 8596.312295016258, 8600.494913390257, 8778.297736180963, 11011.394373309224, 13301.0, 13746.037777355888, 13758.380872860946, 13852.099613525088, 10954.726131846768, 11565.0, 11762.764744704888, 11825.645230643095, 11901.869322414357, 9621.374610650286, 9756.609735610497, 11154.776904462027, 11625.011873990805, 11648.009919156966, 9402.764930876509, 11486.081113511067, 11599.5360185595, 11930.880691192977, 12008.399580020789, 8129.146439623991, 8141.982252218472, 8368.456050356708, 8423.989121305238, 8441.620127094418, 8232.83534329322, 10295.588176473157, 11484.827727583926, 11780.882191177978, 11886.465109070286], "value": 9569.310889844468, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.4057597249086, 1564.1866229560628, 1743.5989722363856, 1796.721508166233, 1822.0798496759135, 7730.8453830923345, 8195.180481951802, 8239.711610093647, 8725.563721813907, 8826.073262307453, 8411.83176336473, 8527.658893644262, 8600.569971501416, 8604.698835540757, 8622.137786221374, 2247.0562363807157, 2261.8303627227942, 2281.3840263128945, 2287.256641591481, 2293.1056887813766, 2257.841951063426, 2267.183813827029, 2336.2173671819874, 2343.8124950003958, 2347.80043696286, 2282.201229569654, 2297.0926484038796, 2306.8731219782903, 2348.4833336665993, 2352.6588644646517, 2290.3701482092392, 2309.4757460076353, 2315.270689732729, 2316.2819525946925, 2317.385892738426, 2304.412374844421, 2310.1336998625516, 2311.641695537194, 2315.1086831569796, 2315.7568455312285, 8603.268722158624, 8621.568921553897, 8650.65397384104, 8682.348823838238, 8695.826083478294, 5069.44236134025, 5134.486551344873, 5148.176291793295, 5180.740962951837, 5229.450907654679, 2967.109867039879, 3157.5579418881375, 3291.4404551226107, 3381.814000230011, 3555.5555555555557, 988.5353883674661, 1069.6363236499549, 1080.4705694209858, 1080.9513571889283, 1086.9619563315325, 10186.38881667095, 10328.27702060856, 11105.611303604335, 11187.832182517268, 11234.775304493864, 3894.9805250973563, 4483.439570053743, 4501.392312037899, 4501.816618939812, 4688.906221875543, 8869.246114080246, 8899.0, 8955.701423293716, 9629.566669499889, 9674.419534827934, 5197.506236907488, 5211.0359583477175, 5211.088059589557, 5232.712200828991, 5236.764345604457, 3909.6481316681634, 4326.307790753527, 4742.691725037862, 4826.0830442215865, 4835.008823191238, 3849.2109117630816, 3888.844446222176, 3944.2900277950243, 3949.7235193536753, 4025.215083058834, 1279.194107712154, 1279.4945996331396, 1282.0833104330447, 1284.242297044748, 1291.728736965248, 825.8265764189588, 894.7092195036639, 912.1516989199976, 918.5085979001202, 951.3245595627044, 4913.754312284372, 5615.494605485526, 5617.21359009739, 5942.64344139353, 5972.492338151305, 442.4734665404368, 442.7586965104026, 443.32835753832967, 456.72596442134454, 460.19695631123903, 3879.9806000969816, 3904.6681032112588, 4051.736637118578, 4054.027033511995, 4062.106336605942, 9591.280653950982, 10354.53404596795, 10454.843177352346, 10496.475176241158, 10527.842082368617, 10120.392776433437, 10378.584856605803, 10431.269811113149, 10445.529951152217, 10449.791004180026, 6845.178578570603, 6949.818530849768, 7627.313541781266, 7868.291853733192, 7892.329152022027, 4762.809487620457, 5645.153227015816, 5645.774169033357, 5723.742431590672, 5741.913871292018, 7746.806329841799, 7908.762737117896, 9581.568829402833, 9656.420614763138, 9777.853332200166, 8229.711960081368, 9770.0, 9789.412635241908, 9855.556499957376, 9889.653862114792, 6773.017912402773, 7159.890217016371, 7342.0, 7361.0, 7444.813879653052, 7306.671199796128, 7365.895115732468, 8047.114817369968, 8370.414071014971, 8377.581120943807, 7172.856542869218, 7437.553746775211, 7451.44114191427, 7527.2096429876265, 7536.886946695694, 7199.748008819666, 7219.783406497813, 7289.161746399232, 7293.124825021031, 7415.480916335805, 6725.058491811053, 6747.359000894907, 6799.626020568916, 6840.897386539305, 6844.828879278058, 4862.343583616308, 4907.950920490749, 4923.236898280772, 4935.62982776286, 5007.198848184273, 4017.879463616096, 4798.640101992295, 4900.0, 4923.335349727884, 4997.925031124463], "value": 4358.815632842739, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.2364563956532, 303.0333236974053, 308.62502059997104, 309.37351862478494, 312.13538498359543, 4457.019455719745, 4831.6902921498795, 5438.864028399292, 5586.128646903282, 5691.4877661010505, 5550.500454959053, 5626.352969408519, 5643.238162848014, 5688.232088668028, 5690.857728556778, 4298.46269216348, 4329.835082458771, 4342.782860856961, 4347.652187824974, 4348.934765978513, 3547.982260088696, 3968.3452230382095, 4200.878556329049, 4337.414449049385, 4361.563843615645, 3735.62643735627, 4195.783222865365, 4205.852795152155, 4207.768572728499, 4216.388623649569, 3461.307738452307, 3905.218956208741, 3950.407438884162, 4227.196832601796, 4233.624072176555, 3010.0969709087403, 3361.8151001694896, 3647.6352364763575, 3652.8356223969718, 3664.560252769658, 5152.510511501401, 5521.365043020024, 5576.693281869496, 5582.720863956786, 5597.468240517144, 3745.513083299181, 3942.48747662802, 4687.921777991047, 4716.339712440261, 4843.612510999147, 4875.634327425457, 5351.892962140774, 5519.034169020405, 6002.249718785152, 6010.699465026732, 3363.747718921091, 3612.277544491112, 3945.309570825123, 3958.3270843956598, 3966.8214930328204, 5222.321098257202, 5544.16837474378, 6225.564210505221, 6298.417648763985, 6298.70876470327, 4033.858814941463, 4042.8787136385954, 4051.39229115635, 4054.412110243998, 4062.968515742129, 3353.983230083834, 3749.8312575934146, 3890.591487893787, 4065.1259979104634, 4077.347624380085, 4374.168907907551, 4739.573438390561, 4795.95204047962, 4812.727345405158, 4819.542143496362, 5287.81024269544, 5584.91622625661, 5956.421548289707, 5985.521158307325, 6066.757329706762, 1319.33373646308, 1357.246728065933, 1362.9318534073257, 1365.6312795545346, 1367.712780316125, 802.2058162419163, 825.5830805443213, 843.4306842881031, 845.4842546046906, 856.3149480415642, 3881.835449365179, 4107.199096176277, 4259.977605374688, 4594.059801726898, 4601.2622489618625, 4345.565443455629, 4692.41344831896, 5110.744462776846, 5131.1277082895995, 5199.618394961272, 3953.920921581552, 4054.8986275342763, 4347.500037495665, 4608.331791890158, 4643.419572553431, 2365.2076554354485, 2673.4786716590465, 2689.3276680829795, 2690.9192724217914, 2708.266709306046, 4917.369207473984, 5142.665726727751, 5282.735863206824, 5286.220352448018, 5308.469153084738, 4214.557471465513, 4726.669133160714, 5291.947080529222, 5297.490215288624, 5319.627626066138, 4504.797284122157, 5066.923996140061, 5151.793928242828, 5211.820789318513, 5300.31095957523, 5130.921976599483, 5152.871178220425, 5168.147255702767, 5174.8965020700125, 5175.870603234949, 4146.834126634901, 4590.724556526486, 4842.854714358575, 5014.595913144325, 5098.1842905135, 5233.39815921174, 5241.842744717665, 5260.8158714446345, 5295.788168473218, 5352.330958630171, 2999.3803346192813, 3112.2612101350664, 3459.550258466383, 3460.100373902753, 3517.050396393011, 4720.811167553396, 4766.8559545708085, 4929.334539837076, 5086.160783470686, 5115.360579927509, 5351.652142610717, 5678.4605462480995, 5881.206037184926, 5991.460768530853, 6063.878182536245, 5140.357455318085, 5674.404187560247, 5976.671283079472, 6002.369751176064, 6042.909356359746, 4832.371791667061, 5677.403872593483, 5870.471657550841, 5874.500667443315, 5903.557233207613, 5517.806876759455, 5622.88754224905, 5955.047192449188, 6003.7898673546215, 6054.212952316171, 4747.0, 5513.61404701667, 5910.586258962004, 5921.437463440966, 5925.703714814156], "value": 4008.7322656359347, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.0804458226596, 756.6557216466508, 807.3500831830374, 815.865382211935, 874.300559552358, 15064.472743453982, 15148.0, 15557.222138893067, 15601.297941592642, 15670.608234794136, 14344.784828227585, 14416.423343066264, 14545.92727036366, 14586.416543338253, 14595.051321664085, 691.8892977123661, 854.8974123105236, 876.544197017552, 890.2699786175339, 895.7044175422128, 847.0978407995465, 848.8896443462341, 850.698002209213, 871.3029576338935, 884.3588398411165, 843.8143608406141, 885.4864178776294, 887.7603047177258, 893.4237416866117, 929.1312622697766, 879.160401816264, 879.7888506758396, 923.1829830599934, 927.7680579855037, 928.0626567167142, 654.3358491131505, 654.7741029344868, 656.3272645538314, 686.2040033561045, 692.4391243093111, 15300.158491282975, 15430.151341676203, 15511.379544818306, 15534.223288835627, 15618.9219053904, 14729.484468043674, 14746.705065898623, 14930.0, 15044.548663540001, 15062.849371506254, 9960.750981225456, 12098.153129280954, 12103.273803571814, 12160.260313214345, 12525.43635536403, 3920.627540383659, 3951.27097557575, 3991.560928297885, 4069.226846899109, 4078.9796051019853, 122689.0, 122887.0, 124161.0, 124301.0, 124539.37730311381, 11465.31208127515, 11506.367149806842, 11506.712332191595, 11560.190786645022, 11652.53389864413, 23774.405639858796, 24074.27777166688, 24190.879045605012, 24236.272911812674, 24265.878670606533, 8111.229433203836, 8230.300424463987, 8259.132791056973, 8386.87419688705, 8415.326773858076, 4295.699301048897, 4393.0, 4495.77521123949, 4600.079984003212, 4639.280911458662, 3390.7456940729544, 3521.7534772566187, 3531.858725650945, 3533.9646603533633, 3535.1869070113503, 532.890757394741, 636.0872148466965, 640.9519286053564, 647.0520687193191, 647.8833809914261, 545.7162275616657, 587.529976019183, 619.6282230661657, 666.7333066773233, 698.8043347862607, 8858.86711699325, 9580.856287155699, 9623.663171788954, 9628.47043412619, 9976.251781116445, 648.9513286503532, 649.5193556768052, 660.1550015979553, 669.8459354348527, 699.0772180721399, 4346.638457221449, 4532.773361331921, 4913.434954980223, 4940.802367905244, 5045.268436076748, 96938.0, 100395.0, 140112.0, 158626.20686896492, 165807.0, 130951.0, 142144.0, 143432.0, 145483.0, 146410.0, 122997.0, 123133.0, 123156.76843231633, 127130.0, 128877.06684399741, 9230.861537077084, 9482.38364506305, 9930.354526955725, 10063.0, 10166.186705063725, 54016.0, 59497.30861692349, 59733.0, 65687.68624627385, 69611.65194173997, 65043.349566505625, 67947.62183323757, 82843.7573436411, 92504.0, 93214.0, 11235.494402751732, 14247.21640309793, 14305.499307524187, 14667.973241872967, 15008.849911500745, 15175.392984280947, 15385.0, 15581.922090389475, 15710.0, 16196.0, 13979.580612581232, 14267.571972840831, 14306.642333941734, 14753.557393278219, 14793.92603036978, 13611.727765444833, 14249.64375890611, 14446.483119272745, 14943.850561494246, 14969.0, 13521.526746563823, 13915.791263131263, 14087.647808804863, 14183.361748721127, 14469.565913022627, 11421.257618254787, 11530.884691153316, 11709.121815863675, 11818.527258909548, 11949.522019119138, 8848.380613357262, 9673.0, 10892.945535272273, 11144.777104457704, 11607.76784464289], "value": 8015.970014058269, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 107.0, 119.0, 117.0, 117.0, 114.0, 117.0, 115.0, 118.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 110.0, 133.0, 156.0, 110.0, 129.0, 132.0, 110.0, 182.0, 138.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 203.0, 218.0, 236.0, 200.0, 201.0, 203.0, 200.0, 198.0, 202.0], "value": 205.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 87.0, 76.0, 144.0, 60.0, 60.0, 59.0, 62.0, 138.0, 59.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 104.0, 106.0, 102.0, 105.0, 132.0, 153.0, 82.0, 71.0, 116.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 130.0, 88.0, 86.0, 88.0, 106.0, 81.0, 131.0, 133.0, 116.0], "value": 109.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 138.0, 149.0, 96.0, 96.0, 94.0, 94.0, 93.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 79.0, 145.0, 133.0, 90.0, 82.0, 152.0, 143.0, 90.0, 90.0], "value": 109.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 70.0, 74.0, 56.0, 58.0, 57.0, 57.0, 58.0, 54.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 62.0, 98.0, 117.0, 114.0, 114.0, 107.0, 72.0, 73.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 87.0, 85.0, 86.0, 98.0, 109.0, 103.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 141.0, 137.0, 133.0, 138.0, 137.0, 142.0, 138.0, 138.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 173.0, 169.0, 193.0, 171.0, 168.0, 168.0, 169.0, 168.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 69.0, 68.0, 71.0, 68.0, 70.0, 68.0, 69.0, 70.0], "value": 69.1, "unit": "score"}]}]} 03:57:31 INFO - Return code: 0 03:57:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:31 ERROR - # TBPL SUCCESS # 03:57:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:57:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:57:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:57:31 INFO - 2016-08-07 03:57:31.631 screenresolution[2323:14182] starting screenresolution argv=screenresolution get 03:57:31 INFO - 2016-08-07 03:57:31.634 screenresolution[2323:14182] Display 0: 1600x1200x32@60 03:57:31 INFO - 2016-08-07 03:57:31.640 screenresolution[2324:14185] starting screenresolution argv=screenresolution list 03:57:31 INFO - Available Modes on Display 0 03:57:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:57:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:57:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:57:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:57:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:57:31 INFO - Intel Iris: 03:57:31 INFO - Chipset Model: Intel Iris 03:57:31 INFO - Type: GPU 03:57:31 INFO - Bus: Built-In 03:57:31 INFO - VRAM (Dynamic, Max): 1536 MB 03:57:31 INFO - Vendor: Intel (0x8086) 03:57:31 INFO - Device ID: 0x0a2e 03:57:31 INFO - Revision ID: 0x0009 03:57:31 INFO - Displays: 03:57:31 INFO - Display: 03:57:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:57:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:57:31 INFO - Display Serial Number: 1600x1200 60 03:57:31 INFO - Main Display: Yes 03:57:31 INFO - Mirror: Off 03:57:31 INFO - Online: Yes 03:57:31 INFO - Rotation: Supported 03:57:31 INFO - Return code: 0 03:57:31 INFO - Running post-action listener: _resource_record_post_action 03:57:31 INFO - [mozharness: 2016-08-07 10:57:31.881975Z] Finished run-tests step (success) 03:57:31 INFO - Running post-run listener: _resource_record_post_run 03:57:31 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 1761280; Write bytes: 709848064; Read time: 123; Write time: 2106 03:57:31 INFO - TinderboxPrint: CPU usage
54.5% 03:57:31 INFO - TinderboxPrint: I/O read bytes / time
1,761,280 / 123 03:57:31 INFO - TinderboxPrint: I/O write bytes / time
709,848,064 / 2,106 03:57:31 INFO - TinderboxPrint: CPU idle
2,201.3 (45.5%) 03:57:31 INFO - TinderboxPrint: CPU system
981.9 (20.3%) 03:57:31 INFO - TinderboxPrint: CPU user
1,658.3 (34.3%) 03:57:31 INFO - TinderboxPrint: Swap in / out
407,949,312 / 0 03:57:31 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 400263680; Write bytes: 396224512; Read time: 29586; Write time: 774 03:57:31 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 1761280; Write bytes: 297673728; Read time: 123; Write time: 1294 03:57:32 INFO - Running post-run listener: _upload_blobber_files 03:57:32 INFO - Blob upload gear active. 03:57:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:57:32 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:57:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:33 INFO - (blobuploader) - INFO - Done attempting. 03:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:57:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:57:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:34 INFO - (blobuploader) - INFO - Done attempting. 03:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:36 INFO - (blobuploader) - INFO - Done attempting. 03:57:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:36 INFO - Return code: 0 03:57:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f642964e24e6c7c5afede84634cd69000e696d0034740fa982d4de1fd23432f3fc2d28089ca10ba45336a61bb1b3ee4db9cdfa38d19cbaaede341f70030a44e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55f6ca70c92c1d3c311892b060d1aa3178c99958e57e2ce89cef1ab45170465d2526b9f80061deb0f32ed3c7ece93d5fba44ca5b85f4676e445eb5be2ffc3e75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb6d71303c8165b18675c2a10dd619a5bcff97ff250c355bb9ec13e3566e7ffef1f11dddf15f6faaa13ee69f6d19853f7b7c71b89c231ec3ef07a37a9e538d58"} 03:57:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:36 INFO - Contents: 03:57:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f642964e24e6c7c5afede84634cd69000e696d0034740fa982d4de1fd23432f3fc2d28089ca10ba45336a61bb1b3ee4db9cdfa38d19cbaaede341f70030a44e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55f6ca70c92c1d3c311892b060d1aa3178c99958e57e2ce89cef1ab45170465d2526b9f80061deb0f32ed3c7ece93d5fba44ca5b85f4676e445eb5be2ffc3e75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb6d71303c8165b18675c2a10dd619a5bcff97ff250c355bb9ec13e3566e7ffef1f11dddf15f6faaa13ee69f6d19853f7b7c71b89c231ec3ef07a37a9e538d58"} 03:57:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:36 INFO - Copying logs to upload dir... 03:57:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.306326 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-07 03:57:36.865374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:36.869057) ========= 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.NTBY49BSgy/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.D8cwzTVtJF/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f642964e24e6c7c5afede84634cd69000e696d0034740fa982d4de1fd23432f3fc2d28089ca10ba45336a61bb1b3ee4db9cdfa38d19cbaaede341f70030a44e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55f6ca70c92c1d3c311892b060d1aa3178c99958e57e2ce89cef1ab45170465d2526b9f80061deb0f32ed3c7ece93d5fba44ca5b85f4676e445eb5be2ffc3e75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb6d71303c8165b18675c2a10dd619a5bcff97ff250c355bb9ec13e3566e7ffef1f11dddf15f6faaa13ee69f6d19853f7b7c71b89c231ec3ef07a37a9e538d58"} build_url:https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/SOBQKiolSPW6FKBCVo02ZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f642964e24e6c7c5afede84634cd69000e696d0034740fa982d4de1fd23432f3fc2d28089ca10ba45336a61bb1b3ee4db9cdfa38d19cbaaede341f70030a44e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55f6ca70c92c1d3c311892b060d1aa3178c99958e57e2ce89cef1ab45170465d2526b9f80061deb0f32ed3c7ece93d5fba44ca5b85f4676e445eb5be2ffc3e75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb6d71303c8165b18675c2a10dd619a5bcff97ff250c355bb9ec13e3566e7ffef1f11dddf15f6faaa13ee69f6d19853f7b7c71b89c231ec3ef07a37a9e538d58"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:36.902871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:36.903206) ========= 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.NTBY49BSgy/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.D8cwzTVtJF/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005496 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 03:57:36.951513) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 03:57:36.951835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 03:57:36.952198) ========= ========= Total master_lag: 0.22 =========