builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0005 starttime: 1448309622.96 results: success (0) buildid: 20151121014332 builduid: 366d0f62097c4c84bad0a3f63b5705d4 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:42.964401) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:42.964874) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:42.965155) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005565 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:42.987729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:42.988131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.002507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.002829) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005283 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.052844) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.053427) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.054081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.054556) ========= 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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 --2015-11-23 12:13:43-- 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% 7.91M=0.001s 2015-11-23 12:13:43 (7.91 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.240948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.241267) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.019082 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:43.291289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:13:43.291653) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 489332006384610e3322739f66729448da0e98d9 --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 489332006384610e3322739f66729448da0e98d9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 2015-11-23 12:13:43,361 truncating revision to first 12 chars 2015-11-23 12:13:43,361 Setting DEBUG logging. 2015-11-23 12:13:43,361 attempt 1/10 2015-11-23 12:13:43,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489332006384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 12:13:45,047 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=1.929185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:13:45.236351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:45.236683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:45.247794) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:45.248123) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:13:45.248541) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-23 12:13:45.248861) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:13:45 INFO - MultiFileLogger online at 20151123 12:13:45 in /builds/slave/test 12:13:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:13:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:13:45 INFO - {'append_to_log': False, 12:13:45 INFO - 'base_work_dir': '/builds/slave/test', 12:13:45 INFO - 'blob_upload_branch': 'Fx-Team', 12:13:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:13:45 INFO - 'branch': 'Fx-Team', 12:13:45 INFO - 'buildbot_json_path': 'buildprops.json', 12:13:45 INFO - 'config_files': ('talos/mac_config.py',), 12:13:45 INFO - 'default_actions': ('clobber', 12:13:45 INFO - 'read-buildbot-config', 12:13:45 INFO - 'download-and-extract', 12:13:45 INFO - 'populate-webroot', 12:13:45 INFO - 'create-virtualenv', 12:13:45 INFO - 'install', 12:13:45 INFO - 'run-tests'), 12:13:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:13:45 INFO - 'download_minidump_stackwalk': True, 12:13:45 INFO - 'download_symbols': 'ondemand', 12:13:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:13:45 INFO - 'tooltool.py': '/tools/tooltool.py', 12:13:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:13:45 INFO - '/tools/misc-python/virtualenv.py')}, 12:13:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:13:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:13:45 INFO - 'installer_path': 'installer.exe', 12:13:45 INFO - 'log_level': 'info', 12:13:45 INFO - 'log_name': 'talos', 12:13:45 INFO - 'log_to_console': True, 12:13:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:13:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:13:45 INFO - 'opt_config_files': (), 12:13:45 INFO - 'pip_index': False, 12:13:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:13:45 INFO - 'cmd': ('bash', 12:13:45 INFO - '-c', 12:13:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:13:45 INFO - 'enabled': True, 12:13:45 INFO - 'halt_on_failure': False, 12:13:45 INFO - 'name': 'check_screen_resolution'},), 12:13:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:13:45 INFO - 'cmd': ('bash', 12:13:45 INFO - '-c', 12:13:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:13:45 INFO - 'enabled': True, 12:13:45 INFO - 'halt_on_failure': False, 12:13:45 INFO - 'name': 'check_screen_resolution'},), 12:13:45 INFO - 'run_cmd_checks_enabled': True, 12:13:45 INFO - 'sps_profile': False, 12:13:45 INFO - 'sps_profile_interval': 0, 12:13:45 INFO - 'suite': 'dromaeojs', 12:13:45 INFO - 'system_bits': '64', 12:13:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:13:45 INFO - 'title': 't-yosemite-r7-0005', 12:13:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:13:45 INFO - 'use_talos_json': True, 12:13:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:13:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:13:45 INFO - 'work_dir': 'build'} 12:13:45 INFO - ##### 12:13:45 INFO - ##### Running clobber step. 12:13:45 INFO - ##### 12:13:45 INFO - Running pre-action listener: _resource_record_pre_action 12:13:45 INFO - Running main action method: clobber 12:13:45 INFO - rmtree: /builds/slave/test/build 12:13:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:13:46 INFO - Running post-action listener: _resource_record_post_action 12:13:46 INFO - ##### 12:13:46 INFO - ##### Running read-buildbot-config step. 12:13:46 INFO - ##### 12:13:46 INFO - Running pre-action listener: _resource_record_pre_action 12:13:46 INFO - Running main action method: read_buildbot_config 12:13:46 INFO - Using buildbot properties: 12:13:46 INFO - { 12:13:46 INFO - "properties": { 12:13:46 INFO - "buildnumber": 18, 12:13:46 INFO - "product": "firefox", 12:13:46 INFO - "script_repo_revision": "production", 12:13:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:13:46 INFO - "repository": "", 12:13:46 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:13:46 INFO - "buildid": "20151121014332", 12:13:46 INFO - "slavename": "t-yosemite-r7-0005", 12:13:46 INFO - "pgo_build": "False", 12:13:46 INFO - "basedir": "/builds/slave/test", 12:13:46 INFO - "project": "", 12:13:46 INFO - "platform": "yosemite_r7", 12:13:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:13:46 INFO - "slavebuilddir": "test", 12:13:46 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:13:46 INFO - "branch": "fx-team", 12:13:46 INFO - "repo_path": "integration/fx-team", 12:13:46 INFO - "stage_platform": "macosx64", 12:13:46 INFO - "builduid": "366d0f62097c4c84bad0a3f63b5705d4", 12:13:46 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:13:46 INFO - }, 12:13:46 INFO - "sourcestamp": { 12:13:46 INFO - "repository": "", 12:13:46 INFO - "hasPatch": false, 12:13:46 INFO - "project": "", 12:13:46 INFO - "branch": "fx-team-macosx64-talos", 12:13:46 INFO - "changes": [ 12:13:46 INFO - { 12:13:46 INFO - "category": null, 12:13:46 INFO - "files": [ 12:13:46 INFO - { 12:13:46 INFO - "url": null, 12:13:46 INFO - "name": "https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:13:46 INFO - } 12:13:46 INFO - ], 12:13:46 INFO - "repository": "", 12:13:46 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 12:13:46 INFO - "who": "dgottwald@mozilla.com", 12:13:46 INFO - "when": 1448101888, 12:13:46 INFO - "number": 6692178, 12:13:46 INFO - "comments": "Bug 644529 - Remove gap between bookmarks toolbar menu buttons and their popups. r=gijs", 12:13:46 INFO - "project": "", 12:13:46 INFO - "at": "Sat 21 Nov 2015 02:31:28", 12:13:46 INFO - "branch": "fx-team-macosx64-talos", 12:13:46 INFO - "revlink": "", 12:13:46 INFO - "properties": [ 12:13:46 INFO - [ 12:13:46 INFO - "buildid", 12:13:46 INFO - "20151121014332", 12:13:46 INFO - "Change" 12:13:46 INFO - ], 12:13:46 INFO - [ 12:13:46 INFO - "builduid", 12:13:46 INFO - "366d0f62097c4c84bad0a3f63b5705d4", 12:13:46 INFO - "Change" 12:13:46 INFO - ], 12:13:46 INFO - [ 12:13:46 INFO - "pgo_build", 12:13:46 INFO - "False", 12:13:46 INFO - "Change" 12:13:46 INFO - ] 12:13:46 INFO - ], 12:13:46 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:13:46 INFO - } 12:13:46 INFO - ], 12:13:46 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:13:46 INFO - } 12:13:46 INFO - } 12:13:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:13:46 INFO - Running post-action listener: _resource_record_post_action 12:13:46 INFO - ##### 12:13:46 INFO - ##### Running download-and-extract step. 12:13:46 INFO - ##### 12:13:46 INFO - Running pre-action listener: _resource_record_pre_action 12:13:46 INFO - Running main action method: download_and_extract 12:13:46 INFO - mkdir: /builds/slave/test/build/tests 12:13:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:46 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json 12:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json 12:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:13:47 INFO - Downloaded 1149 bytes. 12:13:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:13:47 INFO - Using the following test package requirements: 12:13:47 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:13:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:13:47 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:13:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:13:47 INFO - u'jsshell-mac.zip'], 12:13:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:13:47 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:13:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:13:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:13:47 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:13:47 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:13:47 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:13:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:13:47 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:13:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:13:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:13:47 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:13:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:13:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:47 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:13:48 INFO - Downloaded 17525290 bytes. 12:13:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:13:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:13:51 INFO - Return code: 0 12:13:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:13:52 INFO - Downloaded 17525290 bytes. 12:13:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:13:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:13:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:13:56 INFO - Return code: 0 12:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:56 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:13:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:13:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:13:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:13:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:13:56 INFO - Downloaded 11130997 bytes. 12:13:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 12:13:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:13:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:13:57 INFO - Return code: 0 12:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:57 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:13:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:13:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:13:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 12:14:00 INFO - Downloaded 109635538 bytes. 12:14:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:14:00 INFO - mkdir: /builds/slave/test/properties 12:14:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:00 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:00 INFO - Contents: 12:14:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:14:00 INFO - Running post-action listener: _resource_record_post_action 12:14:00 INFO - Running post-action listener: set_extra_try_arguments 12:14:00 INFO - ##### 12:14:00 INFO - ##### Running populate-webroot step. 12:14:00 INFO - ##### 12:14:00 INFO - Running pre-action listener: _resource_record_pre_action 12:14:00 INFO - Running main action method: populate_webroot 12:14:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:14:00 INFO - '../fennec_ids.txt'], 12:14:00 INFO - 'tests': ['tcheck2']}, 12:14:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:00 INFO - '--tppagecycles', 12:14:00 INFO - '7'], 12:14:00 INFO - 'tests': ['tsvgm']}}, 12:14:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:14:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:14:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:14:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'tests': ['damp', 'tps']}, 12:14:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['damp', 'tps']}, 12:14:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:14:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:00 INFO - 'other': {'tests': ['a11yr', 12:14:00 INFO - 'ts_paint', 12:14:00 INFO - 'tpaint', 12:14:00 INFO - 'sessionrestore', 12:14:00 INFO - 'sessionrestore_no_auto_restore']}, 12:14:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['a11yr', 12:14:00 INFO - 'ts_paint', 12:14:00 INFO - 'tpaint', 12:14:00 INFO - 'sessionrestore', 12:14:00 INFO - 'sessionrestore_no_auto_restore']}, 12:14:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['a11yr', 12:14:00 INFO - 'ts_paint', 12:14:00 INFO - 'tpaint', 12:14:00 INFO - 'sessionrestore', 12:14:00 INFO - 'sessionrestore_no_auto_restore']}, 12:14:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['a11yr', 12:14:00 INFO - 'ts_paint', 12:14:00 INFO - 'tpaint', 12:14:00 INFO - 'sessionrestore', 12:14:00 INFO - 'sessionrestore_no_auto_restore']}, 12:14:00 INFO - 'other_l64': {'tests': ['a11yr', 12:14:00 INFO - 'ts_paint', 12:14:00 INFO - 'tpaint', 12:14:00 INFO - 'sessionrestore', 12:14:00 INFO - 'sessionrestore_no_auto_restore']}, 12:14:00 INFO - 'other_nol64': {'tests': ['a11yr', 12:14:00 INFO - 'ts_paint', 12:14:00 INFO - 'tpaint', 12:14:00 INFO - 'sessionrestore', 12:14:00 INFO - 'sessionrestore_no_auto_restore']}, 12:14:00 INFO - 'svgr': {'tests': ['tsvgx', 12:14:00 INFO - 'tsvgr_opacity', 12:14:00 INFO - 'tart', 12:14:00 INFO - 'tscrollx', 12:14:00 INFO - 'cart']}, 12:14:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['tsvgx', 12:14:00 INFO - 'tsvgr_opacity', 12:14:00 INFO - 'tart', 12:14:00 INFO - 'tscrollx', 12:14:00 INFO - 'cart']}, 12:14:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'tests': ['tp5o']}, 12:14:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'talos_options': ['--e10s'], 12:14:00 INFO - 'tests': ['tp5o']}, 12:14:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'talos_options': ['--xperf_path', 12:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:00 INFO - 'tests': ['tp5n']}, 12:14:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:00 INFO - 'talos_options': ['--e10s', 12:14:00 INFO - '--xperf_path', 12:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:00 INFO - 'tests': ['tp5n']}}, 12:14:00 INFO - 'talos.zip': {'path': '', 12:14:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:00 INFO - Running post-action listener: _resource_record_post_action 12:14:00 INFO - ##### 12:14:00 INFO - ##### Running create-virtualenv step. 12:14:00 INFO - ##### 12:14:00 INFO - Running pre-action listener: _resource_record_pre_action 12:14:00 INFO - Running main action method: create_virtualenv 12:14:00 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:00 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 12:14:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:00 INFO - Using real prefix '/tools/python27' 12:14:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:00 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:03 INFO - Installing pip.................done. 12:14:03 INFO - Return code: 0 12:14:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x110151490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11012e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dd269fb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, '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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:03 INFO - 'HOME': '/Users/cltbld', 12:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:03 INFO - 'LOGNAME': 'cltbld', 12:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:03 INFO - 'MOZ_NO_REMOTE': '1', 12:14:03 INFO - 'NO_EM_RESTART': '1', 12:14:03 INFO - 'PAGER': '/bin/cat', 12:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:03 INFO - 'PWD': '/builds/slave/test', 12:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:03 INFO - 'SHELL': '/bin/bash', 12:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:03 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:03 INFO - 'USER': 'cltbld', 12:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:03 INFO - 'XPC_FLAGS': '0x0', 12:14:03 INFO - 'XPC_SERVICE_NAME': '0', 12:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:04 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 12:14:04 INFO - Cleaning up... 12:14:04 INFO - Return code: 0 12:14:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110151490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11012e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dd269fb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, '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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 12:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 12:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:04 INFO - 'HOME': '/Users/cltbld', 12:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:04 INFO - 'LOGNAME': 'cltbld', 12:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:04 INFO - 'MOZ_NO_REMOTE': '1', 12:14:04 INFO - 'NO_EM_RESTART': '1', 12:14:04 INFO - 'PAGER': '/bin/cat', 12:14:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:04 INFO - 'PWD': '/builds/slave/test', 12:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:04 INFO - 'SHELL': '/bin/bash', 12:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:04 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:04 INFO - 'USER': 'cltbld', 12:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:04 INFO - 'XPC_FLAGS': '0x0', 12:14:04 INFO - 'XPC_SERVICE_NAME': '0', 12:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:04 INFO - Downloading/unpacking psutil>=0.7.1 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:14:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:06 INFO - Installing collected packages: psutil 12:14:06 INFO - Running setup.py install for psutil 12:14:06 INFO - building 'psutil._psutil_osx' extension 12:14:06 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 12:14:07 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 12:14:07 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 12:14:07 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 12:14:07 INFO - building 'psutil._psutil_posix' extension 12:14:07 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 12:14:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:14:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:14:07 INFO - ^ 12:14:07 INFO - 1 warning generated. 12:14:07 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 12:14:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:07 INFO - Successfully installed psutil 12:14:07 INFO - Cleaning up... 12:14:07 INFO - Return code: 0 12:14:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:14:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110151490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11012e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dd269fb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, '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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 12:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 12:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:07 INFO - 'HOME': '/Users/cltbld', 12:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:07 INFO - 'LOGNAME': 'cltbld', 12:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:07 INFO - 'MOZ_NO_REMOTE': '1', 12:14:07 INFO - 'NO_EM_RESTART': '1', 12:14:07 INFO - 'PAGER': '/bin/cat', 12:14:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:07 INFO - 'PWD': '/builds/slave/test', 12:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:07 INFO - 'SHELL': '/bin/bash', 12:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:07 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:07 INFO - 'USER': 'cltbld', 12:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:07 INFO - 'XPC_FLAGS': '0x0', 12:14:07 INFO - 'XPC_SERVICE_NAME': '0', 12:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:14:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:14:10 INFO - Installing collected packages: mozsystemmonitor 12:14:10 INFO - Running setup.py install for mozsystemmonitor 12:14:10 INFO - Successfully installed mozsystemmonitor 12:14:10 INFO - Cleaning up... 12:14:10 INFO - Return code: 0 12:14:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x110151490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11012e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dd269fb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, '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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:14:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:10 INFO - 'HOME': '/Users/cltbld', 12:14:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:10 INFO - 'LOGNAME': 'cltbld', 12:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:10 INFO - 'MOZ_NO_REMOTE': '1', 12:14:10 INFO - 'NO_EM_RESTART': '1', 12:14:10 INFO - 'PAGER': '/bin/cat', 12:14:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:10 INFO - 'PWD': '/builds/slave/test', 12:14:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:10 INFO - 'SHELL': '/bin/bash', 12:14:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:10 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:10 INFO - 'USER': 'cltbld', 12:14:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:10 INFO - 'XPC_FLAGS': '0x0', 12:14:10 INFO - 'XPC_SERVICE_NAME': '0', 12:14:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:10 INFO - Downloading/unpacking blobuploader==1.2.4 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:12 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:13 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 12:14:13 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 12:14:13 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 12:14:13 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 12:14:13 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 12:14:13 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 12:14:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:13 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 12:14:13 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 12:14:13 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 12:14:13 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 12:14:13 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 12:14:13 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 12:14:14 INFO - Downloading docopt-0.6.1.tar.gz 12:14:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:14 INFO - Running setup.py install for blobuploader 12:14:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:14 INFO - Running setup.py install for requests 12:14:14 INFO - Running setup.py install for docopt 12:14:14 INFO - Successfully installed blobuploader requests docopt 12:14:14 INFO - Cleaning up... 12:14:14 INFO - Return code: 0 12:14:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x110151490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11012e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dd269fb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, '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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 12:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:14 INFO - 'HOME': '/Users/cltbld', 12:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:14 INFO - 'LOGNAME': 'cltbld', 12:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:14 INFO - 'MOZ_NO_REMOTE': '1', 12:14:14 INFO - 'NO_EM_RESTART': '1', 12:14:14 INFO - 'PAGER': '/bin/cat', 12:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:14 INFO - 'PWD': '/builds/slave/test', 12:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:14 INFO - 'SHELL': '/bin/bash', 12:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:14 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:14 INFO - 'USER': 'cltbld', 12:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:14 INFO - 'XPC_FLAGS': '0x0', 12:14:14 INFO - 'XPC_SERVICE_NAME': '0', 12:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-jlCAcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-OmxPQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-TWOKja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-yQfM8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-8XvYvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pNIQnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-nKWtm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pTdffg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-_Rx8ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-36SutO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-FQ3JkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-k3U7ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-RY1NFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-QjZlkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-tIYeMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ocJVHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-VfNu6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:16 INFO - Running setup.py install for manifestparser 12:14:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:17 INFO - Running setup.py install for mozcrash 12:14:17 INFO - Running setup.py install for mozdebug 12:14:17 INFO - Running setup.py install for mozdevice 12:14:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:17 INFO - Running setup.py install for mozfile 12:14:17 INFO - Running setup.py install for mozhttpd 12:14:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:17 INFO - Running setup.py install for mozinfo 12:14:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Running setup.py install for mozInstall 12:14:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Running setup.py install for mozleak 12:14:18 INFO - Running setup.py install for mozlog 12:14:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Running setup.py install for moznetwork 12:14:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Running setup.py install for mozprocess 12:14:18 INFO - Running setup.py install for mozprofile 12:14:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:18 INFO - Running setup.py install for mozrunner 12:14:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:19 INFO - Running setup.py install for mozscreenshot 12:14:19 INFO - Running setup.py install for moztest 12:14:19 INFO - Running setup.py install for mozversion 12:14:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:19 INFO - Cleaning up... 12:14:19 INFO - Return code: 0 12:14:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x110151490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11012e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dd269fb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, '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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:19 INFO - 'HOME': '/Users/cltbld', 12:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:19 INFO - 'LOGNAME': 'cltbld', 12:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:19 INFO - 'MOZ_NO_REMOTE': '1', 12:14:19 INFO - 'NO_EM_RESTART': '1', 12:14:19 INFO - 'PAGER': '/bin/cat', 12:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:19 INFO - 'PWD': '/builds/slave/test', 12:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:19 INFO - 'SHELL': '/bin/bash', 12:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:19 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:19 INFO - 'USER': 'cltbld', 12:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:19 INFO - 'XPC_FLAGS': '0x0', 12:14:19 INFO - 'XPC_SERVICE_NAME': '0', 12:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-tuJvcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:19 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)) 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-CJx_pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-uoJro1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:20 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-DQ8RAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-rrg7IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:20 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-FnP1wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:20 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-zfglnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:20 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-K6Dp9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:20 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ikDh_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:20 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Mkzccz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-vdacOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:20 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)) 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-6zDJ1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:21 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-AlegA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:21 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ANwKIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:21 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-HlEXfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:21 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)) 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:21 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-QzF99d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:21 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)) 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:21 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-rnhXlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:21 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)) 12:14:21 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:21 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:14:21 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)) 12:14:21 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:21 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - Downloading blessings-1.5.1.tar.gz 12:14:23 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:23 INFO - Installing collected packages: blessings 12:14:23 INFO - Running setup.py install for blessings 12:14:24 INFO - Successfully installed blessings 12:14:24 INFO - Cleaning up... 12:14:24 INFO - Return code: 0 12:14:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:24 INFO - Reading from file tmpfile_stdout 12:14:24 INFO - Current package versions: 12:14:24 INFO - blessings == 1.5.1 12:14:24 INFO - blobuploader == 1.2.4 12:14:24 INFO - docopt == 0.6.1 12:14:24 INFO - manifestparser == 1.1 12:14:24 INFO - mozInstall == 1.12 12:14:24 INFO - mozcrash == 0.16 12:14:24 INFO - mozdebug == 0.1 12:14:24 INFO - mozdevice == 0.47 12:14:24 INFO - mozfile == 1.2 12:14:24 INFO - mozhttpd == 0.7 12:14:24 INFO - mozinfo == 0.9 12:14:24 INFO - mozleak == 0.1 12:14:24 INFO - mozlog == 3.0 12:14:24 INFO - moznetwork == 0.27 12:14:24 INFO - mozprocess == 0.22 12:14:24 INFO - mozprofile == 0.27 12:14:24 INFO - mozrunner == 6.11 12:14:24 INFO - mozscreenshot == 0.1 12:14:24 INFO - mozsystemmonitor == 0.0 12:14:24 INFO - moztest == 0.7 12:14:24 INFO - mozversion == 1.4 12:14:24 INFO - psutil == 3.1.1 12:14:24 INFO - requests == 1.2.3 12:14:24 INFO - wsgiref == 0.1.2 12:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x110151490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11012e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dd269fb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, '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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 12:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 12:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 12:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:24 INFO - 'HOME': '/Users/cltbld', 12:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:24 INFO - 'LOGNAME': 'cltbld', 12:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:24 INFO - 'MOZ_NO_REMOTE': '1', 12:14:24 INFO - 'NO_EM_RESTART': '1', 12:14:24 INFO - 'PAGER': '/bin/cat', 12:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:24 INFO - 'PWD': '/builds/slave/test', 12:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:24 INFO - 'SHELL': '/bin/bash', 12:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:24 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:24 INFO - 'USER': 'cltbld', 12:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:24 INFO - 'XPC_FLAGS': '0x0', 12:14:24 INFO - 'XPC_SERVICE_NAME': '0', 12:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:24 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 1)) 12:14:24 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 2)) 12:14:24 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 3)) 12:14:24 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 4)) 12:14:24 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 5)) 12:14:24 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 6)) 12:14:24 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 7)) 12:14:24 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 8)) 12:14:24 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:14:24 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 3)) 12:14:24 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:14:24 INFO - Cleaning up... 12:14:24 INFO - Return code: 0 12:14:24 INFO - Running post-action listener: _resource_record_post_action 12:14:24 INFO - Running post-action listener: _start_resource_monitoring 12:14:24 INFO - Starting resource monitoring. 12:14:24 INFO - ##### 12:14:24 INFO - ##### Running install step. 12:14:24 INFO - ##### 12:14:24 INFO - Running pre-action listener: _resource_record_pre_action 12:14:24 INFO - Running main action method: install 12:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:24 INFO - Reading from file tmpfile_stdout 12:14:24 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:25 INFO - Reading from file tmpfile_stdout 12:14:25 INFO - Output received: 12:14:25 INFO - Usage: mozinstall [options] installer 12:14:25 INFO - Options: 12:14:25 INFO - -h, --help show this help message and exit 12:14:25 INFO - -d DEST, --destination=DEST 12:14:25 INFO - Directory to install application into. [default: 12:14:25 INFO - "/builds/slave/test"] 12:14:25 INFO - --app=APP Application being installed. [default: firefox] 12:14:25 INFO - mkdir: /builds/slave/test/build/application 12:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:14:55 INFO - Reading from file tmpfile_stdout 12:14:55 INFO - Output received: 12:14:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:14:55 INFO - Running post-action listener: _resource_record_post_action 12:14:55 INFO - ##### 12:14:55 INFO - ##### Running run-tests step. 12:14:55 INFO - ##### 12:14:55 INFO - Running pre-action listener: _resource_record_pre_action 12:14:55 INFO - Running main action method: run_tests 12:14:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:14:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:14:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:14:55 INFO - 2015-11-23 12:14:55.701 screenresolution[1931:11442] starting screenresolution argv=screenresolution get 12:14:55 INFO - 2015-11-23 12:14:55.704 screenresolution[1931:11442] Display 0: 1600x1200x32@60 12:14:55 INFO - 2015-11-23 12:14:55.709 screenresolution[1932:11444] starting screenresolution argv=screenresolution list 12:14:55 INFO - Available Modes on Display 0 12:14:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:14:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:14:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:14:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:14:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:14:55 INFO - Intel Iris: 12:14:55 INFO - Chipset Model: Intel Iris 12:14:55 INFO - Type: GPU 12:14:55 INFO - Bus: Built-In 12:14:55 INFO - VRAM (Dynamic, Max): 1536 MB 12:14:55 INFO - Vendor: Intel (0x8086) 12:14:55 INFO - Device ID: 0x0a2e 12:14:55 INFO - Revision ID: 0x0009 12:14:55 INFO - Displays: 12:14:55 INFO - Display: 12:14:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:14:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:14:55 INFO - Display Serial Number: 1600x1200 60 12:14:55 INFO - Main Display: Yes 12:14:55 INFO - Mirror: Off 12:14:55 INFO - Online: Yes 12:14:55 INFO - Rotation: Supported 12:14:55 INFO - Return code: 0 12:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:14:55 INFO - Python 2.7.3 12:14:55 INFO - Return code: 0 12:14:55 INFO - grabbing minidump binary from tooltool 12:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14: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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100759f0>, '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 0x10fdd4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100688c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:14: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 12:14: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 12:14:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:14:56 INFO - Return code: 0 12:14:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:14:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:14:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:14:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:14:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost'] in /builds/slave/test/build 12:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --webServer localhost 12:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KtfiKm8iXY/Render', 12:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:56 INFO - 'HOME': '/Users/cltbld', 12:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:56 INFO - 'LOGNAME': 'cltbld', 12:14:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:14:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:56 INFO - 'MOZ_NO_REMOTE': '1', 12:14:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:14:56 INFO - 'NO_EM_RESTART': '1', 12:14:56 INFO - 'PAGER': '/bin/cat', 12:14:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:56 INFO - 'PWD': '/builds/slave/test', 12:14:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:56 INFO - 'SHELL': '/bin/bash', 12:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCWkjpyvEw/Listeners', 12:14:56 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 12:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:56 INFO - 'USER': 'cltbld', 12:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:56 INFO - 'XPC_FLAGS': '0x0', 12:14:56 INFO - 'XPC_SERVICE_NAME': '0', 12:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost'] with output_timeout 3600 12:14:56 INFO - mozversion INFO | application_buildid: 20151121014332 12:14:56 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 12:14:56 INFO - mozversion INFO | application_display_name: Nightly 12:14:56 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:14:56 INFO - mozversion INFO | application_name: Firefox 12:14:56 INFO - mozversion INFO | application_remotingname: firefox 12:14:56 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:14:56 INFO - mozversion INFO | application_vendor: Mozilla 12:14:56 INFO - mozversion INFO | application_version: 45.0a1 12:14:56 INFO - mozversion INFO | platform_buildid: 20151121014332 12:14:56 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 12:14:56 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:14:56 INFO - mozversion INFO | platform_version: 45.0a1 12:14:56 INFO - 2015-11-23 12:14:56,250 DEBUG : using testdate: 1448309696 12:14:56 INFO - 2015-11-23 12:14:56,250 DEBUG : actual date: 1448309696 12:14:56 INFO - 2015-11-23 12:14:56,740 INFO : starting webserver on 'localhost:49624' 12:14:56 INFO - 2015-11-23 12:14:56,741 INFO : Starting test suite t-yosemite-r7-0005 12:14:56 INFO - 2015-11-23 12:14:56,741 INFO : Starting test dromaeo_css 12:14:56 INFO - 2015-11-23 12:14:56,741 DEBUG : operating with platform_type : mac_ 12:14:56 INFO - 2015-11-23 12:14:56,742 INFO : Initialising browser for dromaeo_css test... 12:14:56 INFO - 2015-11-23 12:14:56,754 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpFKi8r1/profile http://localhost:49624/getInfo.html 12:14:58 INFO - 2015-11-23 12:14:58,722 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:14:58 INFO - 2015-11-23 12:14:58,723 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:14:58 INFO - 2015-11-23 12:14:58,723 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:14:58 INFO - 2015-11-23 12:14:58,723 DEBUG : BROWSER_OUTPUT: __metrics 12:14:58 INFO - 2015-11-23 12:14:58,740 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:59 INFO - 2015-11-23 12:14:59,527 INFO : Browser initialized. 12:14:59 INFO - 2015-11-23 12:14:59,527 INFO : Running cycle 1/1 for dromaeo_css test... 12:14:59 INFO - 2015-11-23 12:14:59,528 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpFKi8r1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:15:11 INFO - 2015-11-23 12:15:11,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 228614144 12:15:11 INFO - 2015-11-23 12:15:11,317 DEBUG : BROWSER_OUTPUT: 12:16:03 INFO - 2015-11-23 12:16:03,059 DEBUG : BROWSER_OUTPUT: 1448309763050 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] 12:18:13 INFO - 2015-11-23 12:18:13,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49624/tests/dromaeo/cssquery-ext.html) 12:18:15 INFO - 2015-11-23 12:18:15,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 356839424 12:18:15 INFO - 2015-11-23 12:18:15,021 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-23 12:21:17,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/dromaeo/cssquery-ext.html (next: http://localhost:49624/tests/dromaeo/cssquery-jquery.html) 12:21:18 INFO - 2015-11-23 12:21:18,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 364544000 12:21:18 INFO - 2015-11-23 12:21:18,379 DEBUG : BROWSER_OUTPUT: 12:24:20 INFO - 2015-11-23 12:24:20,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49624/tests/dromaeo/cssquery-mootools.html) 12:24:20 INFO - 2015-11-23 12:24:20,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 352542720 12:24:20 INFO - 2015-11-23 12:24:20,890 DEBUG : BROWSER_OUTPUT: 12:27:22 INFO - 2015-11-23 12:27:22,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49624/tests/dromaeo/cssquery-prototype.html) 12:27:23 INFO - 2015-11-23 12:27:23,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 318435328 12:27:23 INFO - 2015-11-23 12:27:23,563 DEBUG : BROWSER_OUTPUT: 12:30:26 INFO - 2015-11-23 12:30:26,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49624/tests/dromaeo/cssquery-yui.html) 12:30:27 INFO - 2015-11-23 12:30:27,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 323014656 12:30:27 INFO - 2015-11-23 12:30:27,158 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/dromaeo/cssquery-yui.html (next: http://localhost:49624/tests/dromaeo/cssquery-dojo.html) 12:33:30 INFO - 2015-11-23 12:33:30,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 363290624 12:33:30 INFO - 2015-11-23 12:33:30,308 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,308 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:33:30 INFO - 2015-11-23 12:33:30,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:33:30 INFO - 2015-11-23 12:33:30,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:33:30 INFO - 2015-11-23 12:33:30,309 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:33:30 INFO - 2015-11-23 12:33:30,309 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3047.314354270289;3410.914727131823;3424.8458819353127;3460.6366331535205;3512.8067956262403;5655.349634792;5789.928863160308;5892.85267868303;5910.290765108188;5976.55175861811;5396.703181325026;5866.530677545797;5911.793087241947;6090.17782599349;6102.023676211807;5273.551748101407;5278.076336641092;5307.814226502073;5323.201519772046;5387.865303367408;4927.457979622239;5413;5442.9727851360885;5471.960327537755;5475.342958844944;4653.325267836179;5194.6883187008525;5282.7622756976025;5413.810516631918;5444.3194600674715;5164.664296820694;5341.2255222992835;5359.839204823861;5375.946240537583;5381.596380271456;5242.6330156889035;5294.788208471657;5315.548178404841;5317.680939143664;5324.494173053592;5644.435556444364;5709;5715.428457154293;5719.513841323493;5756.65460072397;6309.589876658002;6325.9051114233325;6329.87340253197;6345.587536810139;6444.0656104865;6244.188255526798;6359.268684101295;6370.235571731422;6372.745090196387;6379.712912918883;4526.683132180716;4841.975790121062;6067.484263837535;6147.354527774609;6148.907766383508;6272.090546870678;6350;6383.2978372379;6403.775867844603;6409.230892292861;6246.6876656167005;6372.330905254974;6383.840403989844;6389.201349831271;6394.26465956421;6224.875502489925;6313.337099604567;6344.365563443711;6367.108604795332;6368.522360822957;6193.009118541012;6206.441420272197;6303.432691057827;6327.841803954846;6368.363163683687;6342.5560210785725;6352.364763523703;6369;6370.140031095742;6380.330065343072;4933.58064564516;4989.401271847401;5049.065922804293;5067.797288108434;5102.36220472441;3829.636184562462;4402.987312918047;4451.821927122879;4465.173942820588;4515.164694531522;5890.3815099414805;5930.436608522184;5949.0481522956115;5980.760769569256;5985;6196.597221180609;6343.651099189589;6349.55553111287;6361.918473859455;6364.268109167412;5718.628289161191;5773.913391299134;5778.88442231153;5789.392113828072;5790.739416726257;5489.094299440628;5499.422560631157;5503.669779813224;5507.752151153208;5516.641418307797;6326.462250708557;6329.905051424233;6330.8100756977365;6331.841703957438;6368.949123394681;5167.250748641502;6216.316205217513;6291.591046581958;6301.4328710416285;6433.260175079926;6310.1796766420075;6326.145970293951;6332.335104813928;6347.904781428375;6351.364863513611;6158.291796443466;6270.529710271657;6345.0482427636225;6362.236531616236;6372.107904893412;5579.6652200868075;6138.877222455437;6277.12120303167;6296.5277604178955;6333.20834895638;5438.945610544002;6324.430801227912;6324.683765811599;6333.841653958503;6346.270178929482;6104.572679912363;6185.8144255672405;6207.255129384503;6296.275928268308;6311.2426508819235;6011.8881397854175;6011.909821352596;6027.487663548647;6042.395760423922;6042.75828966854;6099.146119543356;6114.2357205349335;6116.021436570128;6156.630602163706;6175.320714721287;6155.2613686356135;6159.599626024474;6164.876702466016;6186.938130618816;6205.751769929333 12:33:30 INFO - 2015-11-23 12:33:30,310 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.8091139468278;574.0356201581344;601.795389567547;616.4205646692112;628.5191828251387;41768;42762.71711848649;42773.78613106938;42782.358264626055;42847.57152428475;45248.54751452484;46039.76980115103;46056.309155362695;46137.769311153395;46144.3078353825;8869.024407315223;8994.550272486382;9010.324225683067;9942.453165075918;10149.238807089461;12143.210691305081;12324.753504929897;12327.260364378166;12333.568325108623;12343.197692150026;12128.757424851497;12221.08341874363;12232.938835305811;12235.755284894296;12251.203671761352;9010.369274150811;9129.315301352359;9161.312901532412;9498.810023799555;11739.94340509354;12036.097292702994;12208.633740987785;12212.984857498503;12213.267203967702;12228;35883.282334353426;41676.79161604203;42296.57703422957;42409.93975150615;42421.36367954483;3264.951025734616;3272.5091236314743;3292.736581073508;3445.1903802606366;3674.5590529136407;29906;29916.70083299161;30348.8482557588;30414;30898.84550577255;2482.404222986488;2820.083472871325;2885.5238885584063;2903.3902880395144;2998.0705981145697;501492;501903.99999999633;502321;505299;507007;57575.56061098422;58353.70823145942;58422.4157758417;58693.70653146792;58748.41251587515;70637.64681176562;71456.64271678713;71456.92814607784;71598.9260161098;71716.64141679258;16457.67084658324;16492;16678.833211667727;16696.666066678597;16725.91637041807;12605.30670813114;12681.556145534862;12691.93654031724;12775.552855650008;12792.6801829955;18337;19721.211151553776;20759.481012974797;20902.23759723234;20936;8833.514156721441;9078;9105.135012173832;9121.863172052424;9130;908.7773495493647;943.3208090175063;1045.29442626227;1068.3910171202494;1087.429099722652;24096.759032409453;24563.017479300626;28443.857780710965;28948.27629309284;29097.709022909923;1015.4313584392763;1087.7280679830042;1095.4358505369742;1208.1844754790482;1225.3138242584182;14718.705625887422;14742.778858317133;14800.777988330183;14958.177300248373;15053.698926021638;550894;552711;555701;556045;556083.2195839076;59405.40594593999;59553;59566.702166489755;59683.403165967786;59787.40212597818;1451.2453524167586;1466.2595389328535;1478.3938585180024;1482.9629259268604;1620.2627804348992;27199;28464.43071138524;28503.429931400842;29128.854355728086;29215;57761.71119144378;59218.703906480194;59299.40700592939;59388;59482.512937176914;475534;485875;486151;486773.13226867275;486831;25822.967081316536;28000.87996480118;32115.948984846404;35017.1986241095;35814.28371432609;38421;44891.65325040254;45907.85230369268;46885.82785430391;47003;34344.82827585846;35751.82124089363;37066.88396414669;37620.247595048495;38688.6131138685;28117.71882281151;31632.84128242396;36207.45688814722;37370.626293737805;38293;36365.81817090898;36485.63514364822;37071;38686.80656596699;38746;30551.777928882595;32270.83864580662;32413.837930810194;32516.51225231671;32742.672573274915;19043.90478047601;23018.654720178874;25599.488010239318;26464;26913.73086269112 12:33:30 INFO - 2015-11-23 12:33:30,311 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.45237108667106;360.5223079419769;362.71345636946813;369.8243334416153;372.53619244041175;16276.348946042173;16675.66648667026;17914.552136196584;20359.98200089997;21044.8947755261;11906.64280071597;12190.756184876298;12219.38903054846;21263;21668.8916555417;5179.14544100224;5320.98901208771;5331.653442526223;5333.146696528556;5335.706536140511;3948.763074215542;4058.822941347006;4072.511298644167;5301.5228629423345;5748.741306641211;5865.32548756892;5921.289445266574;5923.763049478016;5938.346781853993;5953.851153721148;5710.5717071219615;5839.7664093436215;5850.619709718854;5859.4140585941495;5866;5465.262189604432;5584.46947539983;5602.1036634138745;5604.019296623115;5606.943930560683;11384.601538946097;13138.934305328508;13268.004899632566;13325.667433256694;13485.797713034312;2015.5968806238811;2028.6348457277684;2045.6113338465643;2051.9076641551164;2292.083166733303;9674.9516252419;9731.610735570568;9736.269779766475;9749.220062394992;10176.694699159038;1608.7104321222175;1657.3039323484165;1735.5053809664312;1775.2898840463788;1785.3840425053336;102273;110978.44510777475;111488.77022459505;112263.4386828077;113804;11162.609308674157;11181.440927953732;11185.944070279596;11225.382603956697;11318.94340528292;13180.406881690347;13293.60417156204;13339.19964802115;13354;13358.666033349049;8554.401191916631;8584.442011269373;8589.871151932726;8636.136386361439;8658.87011694825;8711.91288087111;8721.08428614999;8733.03936566977;8791.956040219886;8837.513936733541;4279.33670281107;4333.414988976448;4333.804978775963;4363.607275345171;4376.846810361622;1701.8638508919257;1769.3807167491532;1772.2556526259002;1773.1666116925026;1780.5103596510803;883.7834730490943;974.201155052864;1008.4050410257836;1017.1862509991977;1018.0074427433341;20288.985550722406;20502;21109.9445027748;21162.576748464944;21458.141674332852;852.1521086518953;930.2002707299343;948.8829196090946;1014.3305418423805;1036.4662198967537;9844.458554779412;10278.897211027943;10493.160547156362;10537.789244215073;10620.734481638021;673170;812177;817634;827180;828759;118072;126275;129927;130473;130789;1205.180477275461;1206.1918514595068;1266.512392728806;1268.7208814060891;1309.705316303824;18290.54273643116;18753;19041.714374284675;19190.61618767589;19257;34642.61429542891;49462.75268623634;50042.74978625084;50466;52277;55562;69325;69423.95864062144;69463.65268173626;71919.44845791116;9578.521073946136;10245.538950747383;10246.38521688701;10262.230332725225;10279.486025698834;16685.666286673957;19919.402417927486;20337.186512539334;20762.377128686163;21039.684404733634;15961.600959975629;16155.838441615904;16280.43018494347;16538.338466461206;16584.253708583383;15522.22388880574;15568.766468503209;15916.28376723027;16123.758143628089;16297.348106075624;16617.3353065876;16641.251143698806;17178.828211717722;17221.138943052545;17226.397076102276;9892;10080.495975201356;10120.240981926238;10133.44266065344;10177;15889.52331430059;16072.437464688679;16181.919090404472;16514.83485165133;16657.91671041637 12:33:30 INFO - 2015-11-23 12:33:30,315 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1368.33635686692;1562.835902230266;1668.449411694141;1799.2712951254741;1845.5109396010055;7410.147832999207;7595.392368610512;8316.5010099394;8684.001339845903;8716.21554060136;8347.207015333533;8502.574871256427;8536.8719469208;8543.273821725144;8549.70076047337;2072.8549001569895;2129.968050479244;2175.2386664667397;2377.3581133094053;2395.281415575329;1977.2980591889816;2190.8904554772275;2194.0346247651064;2422.697162854643;2423.6001059825107;2328.860268383902;2365.6806331145335;2376.1089591403224;2376.144587948346;2381.57131716291;2107.978920210809;2129.329261282691;2327.522857814144;2352.847064940782;2356.06935260572;2169.609470295346;2171.533120379126;2346.1553840617535;2384.749601291874;2388.737238903719;8240.381971352113;8639.39524233304;8646.135386461367;8657.437266577652;8658.264047555966;5222.138347172712;5299.125644268691;5304.257403963448;5306.2571240026045;5307.071262529081;3569.428891377393;3615.475756015363;3664.9816750916343;3665.248624032067;3668.192997540537;1048.979020419595;1054.915606751458;1055.4353420919847;1090.8581884355062;1098.7088421568292;11468.025217856492;11471;11484.94257528707;11485.827712584234;11495.540178392854;4658.580727734452;4717.43390793107;4756;4778.331033655291;4787.688800227974;9804.852927206097;9807.460589667637;9814.852777208347;9815.803683926424;9817.214622830157;5318.032328038573;5319.973400133052;5329.040772660958;5331.147016477423;5332.093544097435;4851.029794041136;4852.927206091911;4861.854144375674;4863.659543831968;4866.31871537985;3636.4181730922924;3708.128589781399;3723.888283351504;3734.626537346244;3758.530183727034;1167.3521195736448;1174.365842445087;1174.8648905375992;1178.8467499225217;1180.4392913366082;1124.7469319403233;1125.8367536707296;1157.976840463186;1276.393712986324;1381.5164692357594;7943.523388596703;8029.357651387875;8060.879086813702;8104.311133553596;8288;1217.2939694976892;1219.2379762648345;1227.5703503773607;1247.3513772838073;1266.803645434959;6044.909326360108;6154.415330543591;6239.719212635442;6244.063390491463;6311.905321420182;10182.949085254526;10334.594702250577;10483.842742358871;10510.947445262878;10528.26302158857;10178.287519873686;10430.217733670004;10456.163506919429;10482.528286226985;10493.9475302623;7571.697132114764;7655.004849369658;8102.351811855037;8189.631466584018;8195.754127376189;7955.4828936118965;8027.237412445808;8028.759137225892;8035;8040.557769322743;9203.355765096647;9233.076692330982;9265.027172147096;9351.438913665203;9400.012998635046;9250.167484926389;9273.397229180082;9454.905450945678;9471.431714097176;9583.089606487372;6555;7583.62081895892;7587.165411804586;7591.8861217080685;7593.126790419173;6955.652217389212;8158.184181581794;8260.132686067876;8271.131531189138;8276.21375969306;7623.16145224036;7647.082350118021;7726.652300646597;7768.92231077682;7807.219278072147;7487.962560187382;7563.886541701989;7605.315521603082;7625.389968802371;7692.7692169235015;7082.114735658043;7685.769426917202;7737.11023232313;7740.3420709240345;7745.457817952689;6947.513674042769;7006.684699188447;7016.964915175391;7017.333353331425;7019.2629773873;6911.7926462206215;6963.6866341013765;7000.299970003162;7003.474739394667;7014.473914456335 12:33:30 INFO - 2015-11-23 12:33:30,316 DEBUG : BROWSER_OUTPUT: |4;prototype.html;321.55143574713276;329.17541558396215;331.3985117012622;335.95800524934384;337.3051513881405;6377.04344348348;6552.296402935235;6570.868582628351;6597.538172327927;6655.767048153321;5163.845084647457;6319.620822750639;6529.8367540811505;6548.312427195147;6733;4865.635077369194;4921.360223170983;4930.704157750529;4931.161702510564;4936.851894443173;4656.371389862359;4783.449903261135;4935.284383764352;4940.481249468808;4942.678725882824;4472.396226509429;4731.00648863739;4787.377640906678;4798.592119669832;4813.350197723297;4789.712617242942;4802.399700037496;4917.483664215241;4921.040397122562;4934.481879402683;4162.604552567501;4174.144300418407;4174.3321068628875;4180.372944058385;4183.016991007111;6184.226971628546;6321.767255385202;6332.240131184241;6342.682865856735;6347.270063942659;5734.455226753494;5768.942310576883;5779.711014449261;5792.420757924216;5794.275715535558;7007.929920700779;7039.92960070403;7043.929560704379;7044.859102817915;7065.43476521877;4474.507804141542;4594.74728889911;4596.586307232332;4713.835015774432;4724.196886529298;7254.818629534251;7390.29792169743;7393.408527317802;7480.289372509603;7533.773986780406;4662.7668616569035;4728.1252968201;4768.0702263059065;4771.73755443454;4781.187198176319;4675.555822196886;4851.029794041136;4857.319975203403;4866.075445665312;4875.317455556225;5793.391693872167;5810.680412577349;5824.446677565625;5833.854153646193;5840.269966254218;5713.5714821388565;7122.821929451701;7123.074000379917;7126.893096603555;7146.106736657918;1375.9449622015006;1468.5520916120472;1684.8062472815539;1702.114900251862;1708.2654458582929;1088.8040152772578;1099.8570185875785;1115.782422427635;1122.253701288634;1137.1300954769608;6583.539152259296;6596.779595774701;6599.307072757388;6614;6619.702113404908;7389.113306403266;7408.555486670817;7409.666565004588;7419.888701669479;7450.403967682572;6327.3988971047675;6565.901511477332;6570.244421891448;6579.769708060195;6607.504437167232;3875.3799392097694;3911.100446897173;3913.6673382762215;3915.2952468555363;3917.745346552522;7368.189499155089;7372.815679608053;7374.668139933716;7384.52000619958;7391.6304184791625;7364.484486086029;7579.848403031909;7583.2416758323725;7589.58257295854;7629.54222746637;5870.735816888165;7367.8894816577795;7386.482946193715;7394.334509894243;7399.223081576357;5696.487316141567;7106.822329441805;7345.5959922202655;7351.191368949304;7366.042414486083;6746.224184218681;7126;7193.928060719326;7217.386522145676;7364.263573642807;7466.8506629866015;7476.663550140365;7487.775366739006;7498.850022999619;7510.173880872991;4821.2045012572535;4829.782659780389;4833.226683730586;4835.298881662069;4841.515848415131;7141.571505709674;7423.220561841145;7425.517341372793;7429.7399591014055;7448.813779655552;7094.432445404458;7109.253528379446;7116.822079448055;7117.501774875709;7135.892961605477;5409.621326507264;7080.4335653148655;7083.150021997393;7086.610236437045;7091.787246382617;6925.342092501204;6939.410150137295;6947.305269473214;6959.89560156588;6974.965125174342;5754.280714910637;7127.322904324081;7134.8929766052515;7142.535735177197;7144.571325720473;5658.773649053992;6847.109875716125;6963.7562685305775;6981.685824138028;7036.050133231948 12:33:30 INFO - 2015-11-23 12:33:30,317 DEBUG : BROWSER_OUTPUT: |5;yui.html;697.5953946710908;734.7465124532034;748.3190296829886;822.4201937633968;837.4849467577438;17851.464456066322;18104.275828966827;18128.54678633033;18169.364072257475;18171.545711357205;16411.58971025722;16541.83458165418;16551.586210344747;16557.66884662306;16580.088095154762;770.0066913681344;771.5370777533491;964.5611246882669;980.5097451274363;984.1388784813288;720.4308596208989;960.817444685511;980.7989362180772;981.4062492192228;982.0326977926736;1005.9547320370601;1027.0705011964185;1028;1030.7629245273554;1032.292879377625;800.6877317846045;806.8265322955564;813.6541969662928;1020.550957578663;1023.2376879224951;618.2951435363689;670.3129292475203;746.9514481558681;755.5126943121655;763.9159692433827;13362;13467.797983030263;13486.460541578324;13490.123141995837;13490.39293231807;10212.336198147097;12195.919499796839;12376.62870113898;12384.133110682256;12707.491700331975;8628.266597339234;10205.744856378577;10362.222833287458;10474.895251047468;11087.667369978913;3481.651834816523;3512.2448673535314;3522.172289511963;3524.8942531724088;3725.5156829612247;76519.85220221701;76614.61692691501;77166;78283.60858195729;81658;9533.237341012702;9535.952320238355;9558.95220523893;9562;9739.951300243454;21495.247666331605;21597.784022159893;21709.565808684052;21741.13035478563;21743.23898663539;7290.526115802456;7423.035005449257;7592.468527203153;7595.620218989028;7695.192004839411;4081.2653722330265;4169.437125988014;4169.937450938239;4203.390508376268;4337.197618440536;3565.286942611488;3602.0454579536445;3604.351216780952;3607.873724419685;3610.62088480711;638.3361304243628;646.3471893387618;648.0408994687888;649.0329409180288;661.6427129350193;481.2329107631121;488.22616153397263;520.274217466632;550.5898105911042;612.8498517863063;8727.563621818883;9147.63409463614;9170.174684278447;9348.766280843034;9477.95742468328;529.1929807044212;594.6848170469658;605.7637521366671;626.6584711332334;670.4535803320279;3805.6384643458828;3815.2941705783965;3865.1323954289883;3905;4205.137946720914;82977;83069.58465207636;83854.58072709598;83963.32073358621;99113.50443247738;65179;73655.68549415289;78954.81567776488;79607.60196198981;82452;57035.71482142646;75246.71299305148;76104.61947690225;76271.61864190643;76881.2311876874;8622.353323500636;8636.050034496326;8649.956750216208;8872.778180545538;9097.317701172571;50426.991460171324;50774.7306317345;51893.70265743387;51924.990126332465;52332.476675234284;69581;69639;70443;70659.93400659892;70845;10719.088877445192;10817;10959.12327013821;11056.944715276371;11509.482073306888;11773.411329433666;11870.703232419259;12419.875801241871;12578.30819304947;12728.872711272768;11103.777924441627;11299.209055366375;11730.472128754398;11732.354720490455;12310.507579696712;11040.5031773572;11417.429128543707;11523.193376463567;11657;12286.569970051005;10676.412797295912;10712.196585256293;11342;11372.31766094037;11949.163558550817;5737.770489180386;8315.792105197177;9221.354505184841;9657.517124143906;10250.53872575721;9881.110700036743;9888.208943284664;9917.801643967225;9920.603175872884;9942.204623629948 12:33:30 INFO - 2015-11-23 12:33:30,317 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:33:30 INFO - 2015-11-23 12:33:30,318 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:33:30 INFO - 2015-11-23 12:33:30,318 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1523 12:33:30 INFO - 2015-11-23 12:33:30,318 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:33:30 INFO - 2015-11-23 12:33:30,319 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310810305__endTimestamp 12:33:30 INFO - 2015-11-23 12:33:30,319 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,319 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:33:30 INFO - 2015-11-23 12:33:30,319 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:33:30 INFO - 2015-11-23 12:33:30,319 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,319 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5818.31 Median:6104.57 stddev:683.49 (11.2%) stddev-sans-first:650.10 12:33:30 INFO - 2015-11-23 12:33:30,319 DEBUG : BROWSER_OUTPUT: Values: 3047.3 3410.9 3424.8 3460.6 3512.8 5655.3 5789.9 5892.9 5910.3 5976.6 5396.7 5866.5 5911.8 6090.2 6102.0 5273.6 5278.1 5307.8 5323.2 5387.9 4927.5 5413.0 5443.0 5472.0 5475.3 4653.3 5194.7 5282.8 5413.8 5444.3 5164.7 5341.2 5359.8 5375.9 5381.6 5242.6 5294.8 5315.5 5317.7 5324.5 5644.4 5709.0 5715.4 5719.5 5756.7 6309.6 6325.9 6329.9 6345.6 6444.1 6244.2 6359.3 6370.2 6372.7 6379.7 4526.7 4842.0 6067.5 6147.4 6148.9 6272.1 6350.0 6383.3 6403.8 6409.2 6246.7 6372.3 6383.8 6389.2 6394.3 6224.9 6313.3 6344.4 6367.1 6368.5 6193.0 6206.4 6303.4 6327.8 6368.4 6342.6 6352.4 6369.0 6370.1 6380.3 4933.6 4989.4 5049.1 5067.8 5102.4 3829.6 4403.0 4451.8 4465.2 4515.2 5890.4 5930.4 5949.0 5980.8 5985.0 6196.6 6343.7 6349.6 6361.9 6364.3 5718.6 5773.9 5778.9 5789.4 5790.7 5489.1 5499.4 5503.7 5507.8 5516.6 6326.5 6329.9 6330.8 6331.8 6368.9 5167.3 6216.3 6291.6 6301.4 6433.3 6310.2 6326.1 6332.3 6347.9 6351.4 6158.3 6270.5 6345.0 6362.2 6372.1 5579.7 6138.9 6277.1 6296.5 6333.2 5438.9 6324.4 6324.7 6333.8 6346.3 6104.6 6185.8 6207.3 6296.3 6311.2 6011.9 6011.9 6027.5 6042.4 6042.8 6099.1 6114.2 6116.0 6156.6 6175.3 6155.3 6159.6 6164.9 6186.9 6205.8 12:33:30 INFO - 2015-11-23 12:33:30,320 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,320 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66281.36 Median:35384.51 stddev:136924.49 (387.0%) stddev-sans-first:137219.71 12:33:30 INFO - 2015-11-23 12:33:30,321 DEBUG : BROWSER_OUTPUT: Values: 569.8 574.0 601.8 616.4 628.5 41768.0 42762.7 42773.8 42782.4 42847.6 45248.5 46039.8 46056.3 46137.8 46144.3 8869.0 8994.6 9010.3 9942.5 10149.2 12143.2 12324.8 12327.3 12333.6 12343.2 12128.8 12221.1 12232.9 12235.8 12251.2 9010.4 9129.3 9161.3 9498.8 11739.9 12036.1 12208.6 12213.0 12213.3 12228.0 35883.3 41676.8 42296.6 42409.9 42421.4 3265.0 3272.5 3292.7 3445.2 3674.6 29906.0 29916.7 30348.8 30414.0 30898.8 2482.4 2820.1 2885.5 2903.4 2998.1 501492.0 501904.0 502321.0 505299.0 507007.0 57575.6 58353.7 58422.4 58693.7 58748.4 70637.6 71456.6 71456.9 71598.9 71716.6 16457.7 16492.0 16678.8 16696.7 16725.9 12605.3 12681.6 12691.9 12775.6 12792.7 18337.0 19721.2 20759.5 20902.2 20936.0 8833.5 9078.0 9105.1 9121.9 9130.0 908.8 943.3 1045.3 1068.4 1087.4 24096.8 24563.0 28443.9 28948.3 29097.7 1015.4 1087.7 1095.4 1208.2 1225.3 14718.7 14742.8 14800.8 14958.2 15053.7 550894.0 552711.0 555701.0 556045.0 556083.2 59405.4 59553.0 59566.7 59683.4 59787.4 1451.2 1466.3 1478.4 1483.0 1620.3 27199.0 28464.4 28503.4 29128.9 29215.0 57761.7 59218.7 59299.4 59388.0 59482.5 475534.0 485875.0 486151.0 486773.1 486831.0 25823.0 28000.9 32115.9 35017.2 35814.3 38421.0 44891.7 45907.9 46885.8 47003.0 34344.8 35751.8 37066.9 37620.2 38688.6 28117.7 31632.8 36207.5 37370.6 38293.0 36365.8 36485.6 37071.0 38686.8 38746.0 30551.8 32270.8 32413.8 32516.5 32742.7 19043.9 23018.7 25599.5 26464.0 26913.7 12:33:30 INFO - 2015-11-23 12:33:30,321 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,322 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39964.79 Median:10967.50 stddev:130771.70 (1192.4%) stddev-sans-first:131104.72 12:33:30 INFO - 2015-11-23 12:33:30,322 DEBUG : BROWSER_OUTPUT: Values: 354.5 360.5 362.7 369.8 372.5 16276.3 16675.7 17914.6 20360.0 21044.9 11906.6 12190.8 12219.4 21263.0 21668.9 5179.1 5321.0 5331.7 5333.1 5335.7 3948.8 4058.8 4072.5 5301.5 5748.7 5865.3 5921.3 5923.8 5938.3 5953.9 5710.6 5839.8 5850.6 5859.4 5866.0 5465.3 5584.5 5602.1 5604.0 5606.9 11384.6 13138.9 13268.0 13325.7 13485.8 2015.6 2028.6 2045.6 2051.9 2292.1 9675.0 9731.6 9736.3 9749.2 10176.7 1608.7 1657.3 1735.5 1775.3 1785.4 102273.0 110978.4 111488.8 112263.4 113804.0 11162.6 11181.4 11185.9 11225.4 11318.9 13180.4 13293.6 13339.2 13354.0 13358.7 8554.4 8584.4 8589.9 8636.1 8658.9 8711.9 8721.1 8733.0 8792.0 8837.5 4279.3 4333.4 4333.8 4363.6 4376.8 1701.9 1769.4 1772.3 1773.2 1780.5 883.8 974.2 1008.4 1017.2 1018.0 20289.0 20502.0 21109.9 21162.6 21458.1 852.2 930.2 948.9 1014.3 1036.5 9844.5 10278.9 10493.2 10537.8 10620.7 673170.0 812177.0 817634.0 827180.0 828759.0 118072.0 126275.0 129927.0 130473.0 130789.0 1205.2 1206.2 1266.5 1268.7 1309.7 18290.5 18753.0 19041.7 19190.6 19257.0 34642.6 49462.8 50042.7 50466.0 52277.0 55562.0 69325.0 69424.0 69463.7 71919.4 9578.5 10245.5 10246.4 10262.2 10279.5 16685.7 19919.4 20337.2 20762.4 21039.7 15961.6 16155.8 16280.4 16538.3 16584.3 15522.2 15568.8 15916.3 16123.8 16297.3 16617.3 16641.3 17178.8 17221.1 17226.4 9892.0 10080.5 10120.2 10133.4 10177.0 15889.5 16072.4 16181.9 16514.8 16657.9 12:33:30 INFO - 2015-11-23 12:33:30,322 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,322 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5938.98 Median:5319.00 stddev:3119.91 (58.7%) stddev-sans-first:3109.75 12:33:30 INFO - 2015-11-23 12:33:30,324 DEBUG : BROWSER_OUTPUT: Values: 1368.3 1562.8 1668.4 1799.3 1845.5 7410.1 7595.4 8316.5 8684.0 8716.2 8347.2 8502.6 8536.9 8543.3 8549.7 2072.9 2130.0 2175.2 2377.4 2395.3 1977.3 2190.9 2194.0 2422.7 2423.6 2328.9 2365.7 2376.1 2376.1 2381.6 2108.0 2129.3 2327.5 2352.8 2356.1 2169.6 2171.5 2346.2 2384.7 2388.7 8240.4 8639.4 8646.1 8657.4 8658.3 5222.1 5299.1 5304.3 5306.3 5307.1 3569.4 3615.5 3665.0 3665.2 3668.2 1049.0 1054.9 1055.4 1090.9 1098.7 11468.0 11471.0 11484.9 11485.8 11495.5 4658.6 4717.4 4756.0 4778.3 4787.7 9804.9 9807.5 9814.9 9815.8 9817.2 5318.0 5320.0 5329.0 5331.1 5332.1 4851.0 4852.9 4861.9 4863.7 4866.3 3636.4 3708.1 3723.9 3734.6 3758.5 1167.4 1174.4 1174.9 1178.8 1180.4 1124.7 1125.8 1158.0 1276.4 1381.5 7943.5 8029.4 8060.9 8104.3 8288.0 1217.3 1219.2 1227.6 1247.4 1266.8 6044.9 6154.4 6239.7 6244.1 6311.9 10182.9 10334.6 10483.8 10510.9 10528.3 10178.3 10430.2 10456.2 10482.5 10493.9 7571.7 7655.0 8102.4 8189.6 8195.8 7955.5 8027.2 8028.8 8035.0 8040.6 9203.4 9233.1 9265.0 9351.4 9400.0 9250.2 9273.4 9454.9 9471.4 9583.1 6555.0 7583.6 7587.2 7591.9 7593.1 6955.7 8158.2 8260.1 8271.1 8276.2 7623.2 7647.1 7726.7 7768.9 7807.2 7488.0 7563.9 7605.3 7625.4 7692.8 7082.1 7685.8 7737.1 7740.3 7745.5 6947.5 7006.7 7017.0 7017.3 7019.3 6911.8 6963.7 7000.3 7003.5 7014.5 12:33:30 INFO - 2015-11-23 12:33:30,324 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,324 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5761.12 Median:6539.07 stddev:1816.38 (27.8%) stddev-sans-first:1774.99 12:33:30 INFO - 2015-11-23 12:33:30,325 DEBUG : BROWSER_OUTPUT: Values: 321.6 329.2 331.4 336.0 337.3 6377.0 6552.3 6570.9 6597.5 6655.8 5163.8 6319.6 6529.8 6548.3 6733.0 4865.6 4921.4 4930.7 4931.2 4936.9 4656.4 4783.4 4935.3 4940.5 4942.7 4472.4 4731.0 4787.4 4798.6 4813.4 4789.7 4802.4 4917.5 4921.0 4934.5 4162.6 4174.1 4174.3 4180.4 4183.0 6184.2 6321.8 6332.2 6342.7 6347.3 5734.5 5768.9 5779.7 5792.4 5794.3 7007.9 7039.9 7043.9 7044.9 7065.4 4474.5 4594.7 4596.6 4713.8 4724.2 7254.8 7390.3 7393.4 7480.3 7533.8 4662.8 4728.1 4768.1 4771.7 4781.2 4675.6 4851.0 4857.3 4866.1 4875.3 5793.4 5810.7 5824.4 5833.9 5840.3 5713.6 7122.8 7123.1 7126.9 7146.1 1375.9 1468.6 1684.8 1702.1 1708.3 1088.8 1099.9 1115.8 1122.3 1137.1 6583.5 6596.8 6599.3 6614.0 6619.7 7389.1 7408.6 7409.7 7419.9 7450.4 6327.4 6565.9 6570.2 6579.8 6607.5 3875.4 3911.1 3913.7 3915.3 3917.7 7368.2 7372.8 7374.7 7384.5 7391.6 7364.5 7579.8 7583.2 7589.6 7629.5 5870.7 7367.9 7386.5 7394.3 7399.2 5696.5 7106.8 7345.6 7351.2 7366.0 6746.2 7126.0 7193.9 7217.4 7364.3 7466.9 7476.7 7487.8 7498.9 7510.2 4821.2 4829.8 4833.2 4835.3 4841.5 7141.6 7423.2 7425.5 7429.7 7448.8 7094.4 7109.3 7116.8 7117.5 7135.9 5409.6 7080.4 7083.2 7086.6 7091.8 6925.3 6939.4 6947.3 6959.9 6975.0 5754.3 7127.3 7134.9 7142.5 7144.6 5658.8 6847.1 6963.8 6981.7 7036.1 12:33:30 INFO - 2015-11-23 12:33:30,325 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,325 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18335.17 Median:539.89 stddev:25305.41 (4687.1%) stddev-sans-first:25341.75 12:33:30 INFO - 2015-11-23 12:33:30,326 DEBUG : BROWSER_OUTPUT: Values: 697.6 734.7 748.3 822.4 837.5 17851.5 18104.3 18128.5 18169.4 18171.5 16411.6 16541.8 16551.6 16557.7 16580.1 770.0 771.5 964.6 980.5 984.1 720.4 960.8 980.8 981.4 982.0 1006.0 1027.1 1028.0 1030.8 1032.3 800.7 806.8 813.7 1020.6 1023.2 618.3 670.3 747.0 755.5 763.9 13362.0 13467.8 13486.5 13490.1 13490.4 10212.3 12195.9 12376.6 12384.1 12707.5 8628.3 10205.7 10362.2 10474.9 11087.7 3481.7 3512.2 3522.2 3524.9 3725.5 76519.9 76614.6 77166.0 78283.6 81658.0 9533.2 9536.0 9559.0 9562.0 9740.0 21495.2 21597.8 21709.6 21741.1 21743.2 7290.5 7423.0 7592.5 7595.6 7695.2 4081.3 4169.4 4169.9 4203.4 4337.2 3565.3 3602.0 3604.4 3607.9 3610.6 638.3 646.3 648.0 649.0 661.6 481.2 488.2 520.3 550.6 612.8 8727.6 9147.6 9170.2 9348.8 9478.0 529.2 594.7 605.8 626.7 670.5 3805.6 3815.3 3865.1 3905.0 4205.1 82977.0 83069.6 83854.6 83963.3 99113.5 65179.0 73655.7 78954.8 79607.6 82452.0 57035.7 75246.7 76104.6 76271.6 76881.2 8622.4 8636.1 8650.0 8872.8 9097.3 50427.0 50774.7 51893.7 51925.0 52332.5 69581.0 69639.0 70443.0 70659.9 70845.0 10719.1 10817.0 10959.1 11056.9 11509.5 11773.4 11870.7 12419.9 12578.3 12728.9 11103.8 11299.2 11730.5 11732.4 12310.5 11040.5 11417.4 11523.2 11657.0 12286.6 10676.4 10712.2 11342.0 11372.3 11949.2 5737.8 8315.8 9221.4 9657.5 10250.5 9881.1 9888.2 9917.8 9920.6 9942.2 12:33:30 INFO - 2015-11-23 12:33:30,327 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:33:30 INFO - 2015-11-23 12:33:30,327 DEBUG : BROWSER_OUTPUT: 12:33:30 INFO - 2015-11-23 12:33:30,768 INFO : Browser exited with error code: 0 12:33:30 INFO - 2015-11-23 12:33:30,793 INFO : Completed test dromaeo_css (00:18:34) 12:33:30 INFO - 2015-11-23 12:33:30,793 INFO : Starting test kraken 12:33:30 INFO - 2015-11-23 12:33:30,793 DEBUG : operating with platform_type : mac_ 12:33:30 INFO - 2015-11-23 12:33:30,793 INFO : Initialising browser for kraken test... 12:33:30 INFO - 2015-11-23 12:33:30,805 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpNGZM7G/profile http://localhost:49624/getInfo.html 12:33:32 INFO - 2015-11-23 12:33:32,779 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:33:32 INFO - 2015-11-23 12:33:32,779 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:33:32 INFO - 2015-11-23 12:33:32,779 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:33:32 INFO - 2015-11-23 12:33:32,779 DEBUG : BROWSER_OUTPUT: __metrics 12:33:32 INFO - 2015-11-23 12:33:32,797 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:33:33 INFO - 2015-11-23 12:33:33,412 INFO : Browser initialized. 12:33:33 INFO - 2015-11-23 12:33:33,412 INFO : Running cycle 1/1 for kraken test... 12:33:33 INFO - 2015-11-23 12:33:33,413 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpNGZM7G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:33:45 INFO - 2015-11-23 12:33:45,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 226258944 12:33:45 INFO - 2015-11-23 12:33:45,280 DEBUG : BROWSER_OUTPUT: 12:33:47 INFO - 2015-11-23 12:33:47,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49624/tests/kraken/driver.html?testName=audio-beat-detection) 12:33:48 INFO - 2015-11-23 12:33:48,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 275865600 12:33:48 INFO - 2015-11-23 12:33:48,364 DEBUG : BROWSER_OUTPUT: 12:33:50 INFO - 2015-11-23 12:33:50,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49624/tests/kraken/driver.html?testName=audio-dft) 12:33:51 INFO - 2015-11-23 12:33:51,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 290033664 12:33:51 INFO - 2015-11-23 12:33:51,506 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-11-23 12:33:54,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49624/tests/kraken/driver.html?testName=audio-fft) 12:33:55 INFO - 2015-11-23 12:33:55,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 276549632 12:33:55 INFO - 2015-11-23 12:33:55,293 DEBUG : BROWSER_OUTPUT: 12:33:57 INFO - 2015-11-23 12:33:57,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49624/tests/kraken/driver.html?testName=audio-oscillator) 12:33:57 INFO - 2015-11-23 12:33:57,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 279937024 12:33:57 INFO - 2015-11-23 12:33:57,746 DEBUG : BROWSER_OUTPUT: 12:33:59 INFO - 2015-11-23 12:33:59,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:00 INFO - 2015-11-23 12:34:00,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 282222592 12:34:00 INFO - 2015-11-23 12:34:00,447 DEBUG : BROWSER_OUTPUT: 12:34:03 INFO - 2015-11-23 12:34:03,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49624/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:03 INFO - 2015-11-23 12:34:03,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 282877952 12:34:03 INFO - 2015-11-23 12:34:03,788 DEBUG : BROWSER_OUTPUT: 12:34:06 INFO - 2015-11-23 12:34:06,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49624/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:07 INFO - 2015-11-23 12:34:07,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 281374720 12:34:07 INFO - 2015-11-23 12:34:07,212 DEBUG : BROWSER_OUTPUT: 12:34:09 INFO - 2015-11-23 12:34:09,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49624/tests/kraken/driver.html?testName=json-parse-financial) 12:34:10 INFO - 2015-11-23 12:34:10,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 281612288 12:34:10 INFO - 2015-11-23 12:34:10,462 DEBUG : BROWSER_OUTPUT: 12:34:11 INFO - 2015-11-23 12:34:11,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:12 INFO - 2015-11-23 12:34:12,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 317652992 12:34:12 INFO - 2015-11-23 12:34:12,563 DEBUG : BROWSER_OUTPUT: 12:34:14 INFO - 2015-11-23 12:34:14,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:14 INFO - 2015-11-23 12:34:14,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 317104128 12:34:14 INFO - 2015-11-23 12:34:14,943 DEBUG : BROWSER_OUTPUT: 12:34:17 INFO - 2015-11-23 12:34:17,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:17 INFO - 2015-11-23 12:34:17,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 322981888 12:34:17 INFO - 2015-11-23 12:34:17,635 DEBUG : BROWSER_OUTPUT: 12:34:20 INFO - 2015-11-23 12:34:20,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:20 INFO - 2015-11-23 12:34:20,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 325234688 12:34:20 INFO - 2015-11-23 12:34:20,747 DEBUG : BROWSER_OUTPUT: 12:34:23 INFO - 2015-11-23 12:34:23,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:23 INFO - 2015-11-23 12:34:23,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 325984256 12:34:23 INFO - 2015-11-23 12:34:23,827 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49624/tests/kraken/driver.html?testName=ai-astar) 12:34:25 INFO - 2015-11-23 12:34:25,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 384126976 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;101;109;108;107;97;109;101;107 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;121;168;153;117;138;119;153;140;117 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;179;183;183;183;185;184;187;185;181 12:34:25 INFO - 2015-11-23 12:34:25,872 DEBUG : BROWSER_OUTPUT: |3;audio-fft;60;71;70;73;56;59;58;71;73;57 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;87;79;120;81;109;109;137;74;76;109 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;85;86;89;131;86;86;85;85;85 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;137;94;92;93;92;93;93;93;93;93 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;87;88;86;86;86;84;86;87;86 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;54;53;52;55;54;64;53;53 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;65;66;64;67;67;67 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;94;106;81;80;81;81;84;82;81 12:34:25 INFO - 2015-11-23 12:34:25,873 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;120;123;125;115;120;120;114;130;123 12:34:25 INFO - 2015-11-23 12:34:25,874 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;123;165;170;132;132;133;135;134;132 12:34:25 INFO - 2015-11-23 12:34:25,874 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;78;86;90;91;90;67;65;64 12:34:25 INFO - 2015-11-23 12:34:25,874 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:34:25 INFO - 2015-11-23 12:34:25,874 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1032 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310865871__endTimestamp 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.60 Median:108.50 stddev:4.30 (4.0%) stddev-sans-first:4.47 12:34:25 INFO - 2015-11-23 12:34:25,876 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 101.0 109.0 108.0 107.0 97.0 109.0 101.0 107.0 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:137.50 Median:144.50 stddev:18.27 (12.6%) stddev-sans-first:18.90 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: Values: 149.0 121.0 168.0 153.0 117.0 138.0 119.0 153.0 140.0 117.0 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:2.21 (1.2%) stddev-sans-first:2.35 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: Values: 183.0 179.0 183.0 183.0 183.0 185.0 184.0 187.0 185.0 181.0 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.80 Median:70.50 stddev:7.30 (10.4%) stddev-sans-first:7.53 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: Values: 60.0 71.0 70.0 73.0 56.0 59.0 58.0 71.0 73.0 57.0 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,877 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.10 Median:75.00 stddev:21.60 (28.8%) stddev-sans-first:22.53 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: Values: 87.0 79.0 120.0 81.0 109.0 109.0 137.0 74.0 76.0 109.0 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:86.00 stddev:14.32 (16.6%) stddev-sans-first:15.10 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 86.0 89.0 131.0 86.0 86.0 85.0 85.0 85.0 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:97.30 Median:93.00 stddev:13.96 (15.0%) stddev-sans-first:0.60 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: Values: 137.0 94.0 92.0 93.0 92.0 93.0 93.0 93.0 93.0 93.0 12:34:25 INFO - 2015-11-23 12:34:25,878 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,879 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 12:34:25 INFO - 2015-11-23 12:34:25,879 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 88.0 86.0 86.0 86.0 84.0 86.0 87.0 86.0 12:34:25 INFO - 2015-11-23 12:34:25,879 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,879 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.50 stddev:3.43 (6.3%) stddev-sans-first:3.62 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 54.0 53.0 52.0 55.0 54.0 64.0 53.0 53.0 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.50 stddev:1.73 (2.6%) stddev-sans-first:1.69 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 65.0 66.0 64.0 67.0 67.0 67.0 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:81.50 stddev:8.71 (10.7%) stddev-sans-first:8.79 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 106.0 81.0 80.0 81.0 81.0 84.0 82.0 81.0 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:122.00 stddev:4.63 (3.8%) stddev-sans-first:4.91 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: Values: 121.0 120.0 123.0 125.0 115.0 120.0 120.0 114.0 130.0 123.0 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.90 Median:133.50 stddev:15.47 (11.6%) stddev-sans-first:16.26 12:34:25 INFO - 2015-11-23 12:34:25,880 DEBUG : BROWSER_OUTPUT: Values: 133.0 123.0 165.0 170.0 132.0 132.0 133.0 135.0 134.0 132.0 12:34:25 INFO - 2015-11-23 12:34:25,881 DEBUG : BROWSER_OUTPUT: 12:34:25 INFO - 2015-11-23 12:34:25,881 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:82.00 stddev:12.17 (14.8%) stddev-sans-first:12.10 12:34:25 INFO - 2015-11-23 12:34:25,881 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 78.0 86.0 90.0 91.0 90.0 67.0 65.0 64.0 12:34:25 INFO - 2015-11-23 12:34:25,881 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:34:25 INFO - 2015-11-23 12:34:25,881 DEBUG : BROWSER_OUTPUT: 12:34:26 INFO - 2015-11-23 12:34:26,490 INFO : Browser exited with error code: 0 12:34:26 INFO - 2015-11-23 12:34:26,538 INFO : Completed test kraken (00:00:55) 12:34:26 INFO - 2015-11-23 12:34:26,538 INFO : Starting test v8_7 12:34:26 INFO - 2015-11-23 12:34:26,538 DEBUG : operating with platform_type : mac_ 12:34:26 INFO - 2015-11-23 12:34:26,538 INFO : Initialising browser for v8_7 test... 12:34:26 INFO - 2015-11-23 12:34:26,550 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpkasloi/profile http://localhost:49624/getInfo.html 12:34:28 INFO - 2015-11-23 12:34:28,488 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:34:28 INFO - 2015-11-23 12:34:28,488 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:34:28 INFO - 2015-11-23 12:34:28,488 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:34:28 INFO - 2015-11-23 12:34:28,488 DEBUG : BROWSER_OUTPUT: __metrics 12:34:28 INFO - 2015-11-23 12:34:28,495 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:34:29 INFO - 2015-11-23 12:34:29,161 INFO : Browser initialized. 12:34:29 INFO - 2015-11-23 12:34:29,161 INFO : Running cycle 1/1 for v8_7 test... 12:34:29 INFO - 2015-11-23 12:34:29,162 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpkasloi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:34:41 INFO - 2015-11-23 12:34:41,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 225611776 12:34:41 INFO - 2015-11-23 12:34:41,012 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49624/tests/v8_7/run.html (next: http://localhost:49624/tests/v8_7/run.html) 12:35:02 INFO - 2015-11-23 12:35:02,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 296800256 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |0;Richards;147.64506127270042 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.86468112657818 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4721.698113207547 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1709.4017094017095 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |6;Boyer;13675.675675675675 12:35:02 INFO - 2015-11-23 12:35:02,794 DEBUG : BROWSER_OUTPUT: |7;RegExp;28000 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: |8;Splay;760.4562737642585 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4559.090909090909 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310902787__endTimestamp 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.65 Median:147.65 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: Values: 147.6 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.86 Median:161.86 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: Values: 161.9 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,795 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: Values: 279.3 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4721.70 Median:4721.70 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: Values: 4721.7 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1709.40 Median:1709.40 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: Values: 1709.4 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: Values: 789.3 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13675.68 Median:13675.68 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: Values: 13675.7 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,796 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28000.00 Median:28000.00 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: Values: 28000.0 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:760.46 Median:760.46 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: Values: 760.5 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4559.09 Median:4559.09 stddev:0.00 (0.0%) 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: Values: 4559.1 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:02 INFO - 2015-11-23 12:35:02,797 DEBUG : BROWSER_OUTPUT: 12:35:03 INFO - 2015-11-23 12:35:03,368 INFO : Browser exited with error code: 0 12:35:03 INFO - 2015-11-23 12:35:03,386 INFO : Completed test v8_7 (00:00:36) 12:35:03 INFO - 2015-11-23 12:35:03,790 INFO : Completed test suite (00:20:07) 12:35:03 INFO - 2015-11-23 12:35:03,790 DEBUG : Working with test: dromaeo_css 12:35:03 INFO - 2015-11-23 12:35:03,790 DEBUG : Generating results file: dromaeo_css 12:35:03 INFO - 2015-11-23 12:35:03,791 DEBUG : Working with test: kraken 12:35:03 INFO - 2015-11-23 12:35:03,791 DEBUG : Generating results file: kraken 12:35:03 INFO - 2015-11-23 12:35:03,791 INFO : javascript benchmark 12:35:03 INFO - 2015-11-23 12:35:03,791 DEBUG : Working with test: v8_7 12:35:03 INFO - 2015-11-23 12:35:03,791 DEBUG : Generating results file: v8_7 12:35:03 INFO - 2015-11-23 12:35:03,791 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:35:07 INFO - 2015-11-23 12:35:07,234 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 12:35:07 INFO - 2015-11-23 12:35:07,234 DEBUG : process_Request line: dromaeo_css 7664.31 graph.html#tests=[[72,64,59]] 12:35:07 INFO - 2015-11-23 12:35:07,235 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:35:07 INFO - 2015-11-23 12:35:07,351 DEBUG : process_Request line: kraken 1405.40 graph.html#tests=[[232,64,59]] 12:35:07 INFO - 2015-11-23 12:35:07,351 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:35:07 INFO - 2015-11-23 12:35:07,472 DEBUG : process_Request line: v8_7 20155.97 graph.html#tests=[[230,64,59]] 12:35:07 INFO - 2015-11-23 12:35:07,473 INFO : javascript benchmark 12:35:07 INFO - 2015-11-23 12:35:07,475 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3047.314354270289, 3410.914727131823, 3424.8458819353127, 3460.6366331535205, 3512.8067956262403, 5655.349634792, 5789.928863160308, 5892.85267868303, 5910.290765108188, 5976.55175861811, 5396.703181325026, 5866.530677545797, 5911.793087241947, 6090.17782599349, 6102.023676211807, 5273.551748101407, 5278.076336641092, 5307.814226502073, 5323.201519772046, 5387.865303367408, 4927.457979622239, 5413.0, 5442.9727851360885, 5471.960327537755, 5475.342958844944, 4653.325267836179, 5194.6883187008525, 5282.7622756976025, 5413.810516631918, 5444.3194600674715, 5164.664296820694, 5341.2255222992835, 5359.839204823861, 5375.946240537583, 5381.596380271456, 5242.6330156889035, 5294.788208471657, 5315.548178404841, 5317.680939143664, 5324.494173053592, 5644.435556444364, 5709.0, 5715.428457154293, 5719.513841323493, 5756.65460072397, 6309.589876658002, 6325.9051114233325, 6329.87340253197, 6345.587536810139, 6444.0656104865, 6244.188255526798, 6359.268684101295, 6370.235571731422, 6372.745090196387, 6379.712912918883, 4526.683132180716, 4841.975790121062, 6067.484263837535, 6147.354527774609, 6148.907766383508, 6272.090546870678, 6350.0, 6383.2978372379, 6403.775867844603, 6409.230892292861, 6246.6876656167005, 6372.330905254974, 6383.840403989844, 6389.201349831271, 6394.26465956421, 6224.875502489925, 6313.337099604567, 6344.365563443711, 6367.108604795332, 6368.522360822957, 6193.009118541012, 6206.441420272197, 6303.432691057827, 6327.841803954846, 6368.363163683687, 6342.5560210785725, 6352.364763523703, 6369.0, 6370.140031095742, 6380.330065343072, 4933.58064564516, 4989.401271847401, 5049.065922804293, 5067.797288108434, 5102.36220472441, 3829.636184562462, 4402.987312918047, 4451.821927122879, 4465.173942820588, 4515.164694531522, 5890.3815099414805, 5930.436608522184, 5949.0481522956115, 5980.760769569256, 5985.0, 6196.597221180609, 6343.651099189589, 6349.55553111287, 6361.918473859455, 6364.268109167412, 5718.628289161191, 5773.913391299134, 5778.88442231153, 5789.392113828072, 5790.739416726257, 5489.094299440628, 5499.422560631157, 5503.669779813224, 5507.752151153208, 5516.641418307797, 6326.462250708557, 6329.905051424233, 6330.8100756977365, 6331.841703957438, 6368.949123394681, 5167.250748641502, 6216.316205217513, 6291.591046581958, 6301.4328710416285, 6433.260175079926, 6310.1796766420075, 6326.145970293951, 6332.335104813928, 6347.904781428375, 6351.364863513611, 6158.291796443466, 6270.529710271657, 6345.0482427636225, 6362.236531616236, 6372.107904893412, 5579.6652200868075, 6138.877222455437, 6277.12120303167, 6296.5277604178955, 6333.20834895638, 5438.945610544002, 6324.430801227912, 6324.683765811599, 6333.841653958503, 6346.270178929482, 6104.572679912363, 6185.8144255672405, 6207.255129384503, 6296.275928268308, 6311.2426508819235, 6011.8881397854175, 6011.909821352596, 6027.487663548647, 6042.395760423922, 6042.75828966854, 6099.146119543356, 6114.2357205349335, 6116.021436570128, 6156.630602163706, 6175.320714721287, 6155.2613686356135, 6159.599626024474, 6164.876702466016, 6186.938130618816, 6205.751769929333], "unit": "ms", "name": "dojo.html", "value": 5774.307342848729}, {"lowerIsBetter": false, "replicates": [569.8091139468278, 574.0356201581344, 601.795389567547, 616.4205646692112, 628.5191828251387, 41768.0, 42762.71711848649, 42773.78613106938, 42782.358264626055, 42847.57152428475, 45248.54751452484, 46039.76980115103, 46056.309155362695, 46137.769311153395, 46144.3078353825, 8869.024407315223, 8994.550272486382, 9010.324225683067, 9942.453165075918, 10149.238807089461, 12143.210691305081, 12324.753504929897, 12327.260364378166, 12333.568325108623, 12343.197692150026, 12128.757424851497, 12221.08341874363, 12232.938835305811, 12235.755284894296, 12251.203671761352, 9010.369274150811, 9129.315301352359, 9161.312901532412, 9498.810023799555, 11739.94340509354, 12036.097292702994, 12208.633740987785, 12212.984857498503, 12213.267203967702, 12228.0, 35883.282334353426, 41676.79161604203, 42296.57703422957, 42409.93975150615, 42421.36367954483, 3264.951025734616, 3272.5091236314743, 3292.736581073508, 3445.1903802606366, 3674.5590529136407, 29906.0, 29916.70083299161, 30348.8482557588, 30414.0, 30898.84550577255, 2482.404222986488, 2820.083472871325, 2885.5238885584063, 2903.3902880395144, 2998.0705981145697, 501492.0, 501903.99999999633, 502321.0, 505299.0, 507007.0, 57575.56061098422, 58353.70823145942, 58422.4157758417, 58693.70653146792, 58748.41251587515, 70637.64681176562, 71456.64271678713, 71456.92814607784, 71598.9260161098, 71716.64141679258, 16457.67084658324, 16492.0, 16678.833211667727, 16696.666066678597, 16725.91637041807, 12605.30670813114, 12681.556145534862, 12691.93654031724, 12775.552855650008, 12792.6801829955, 18337.0, 19721.211151553776, 20759.481012974797, 20902.23759723234, 20936.0, 8833.514156721441, 9078.0, 9105.135012173832, 9121.863172052424, 9130.0, 908.7773495493647, 943.3208090175063, 1045.29442626227, 1068.3910171202494, 1087.429099722652, 24096.759032409453, 24563.017479300626, 28443.857780710965, 28948.27629309284, 29097.709022909923, 1015.4313584392763, 1087.7280679830042, 1095.4358505369742, 1208.1844754790482, 1225.3138242584182, 14718.705625887422, 14742.778858317133, 14800.777988330183, 14958.177300248373, 15053.698926021638, 550894.0, 552711.0, 555701.0, 556045.0, 556083.2195839076, 59405.40594593999, 59553.0, 59566.702166489755, 59683.403165967786, 59787.40212597818, 1451.2453524167586, 1466.2595389328535, 1478.3938585180024, 1482.9629259268604, 1620.2627804348992, 27199.0, 28464.43071138524, 28503.429931400842, 29128.854355728086, 29215.0, 57761.71119144378, 59218.703906480194, 59299.40700592939, 59388.0, 59482.512937176914, 475534.0, 485875.0, 486151.0, 486773.13226867275, 486831.0, 25822.967081316536, 28000.87996480118, 32115.948984846404, 35017.1986241095, 35814.28371432609, 38421.0, 44891.65325040254, 45907.85230369268, 46885.82785430391, 47003.0, 34344.82827585846, 35751.82124089363, 37066.88396414669, 37620.247595048495, 38688.6131138685, 28117.71882281151, 31632.84128242396, 36207.45688814722, 37370.626293737805, 38293.0, 36365.81817090898, 36485.63514364822, 37071.0, 38686.80656596699, 38746.0, 30551.777928882595, 32270.83864580662, 32413.837930810194, 32516.51225231671, 32742.672573274915, 19043.90478047601, 23018.654720178874, 25599.488010239318, 26464.0, 26913.73086269112], "unit": "ms", "name": "ext.html", "value": 20533.877993626003}, {"lowerIsBetter": false, "replicates": [354.45237108667106, 360.5223079419769, 362.71345636946813, 369.8243334416153, 372.53619244041175, 16276.348946042173, 16675.66648667026, 17914.552136196584, 20359.98200089997, 21044.8947755261, 11906.64280071597, 12190.756184876298, 12219.38903054846, 21263.0, 21668.8916555417, 5179.14544100224, 5320.98901208771, 5331.653442526223, 5333.146696528556, 5335.706536140511, 3948.763074215542, 4058.822941347006, 4072.511298644167, 5301.5228629423345, 5748.741306641211, 5865.32548756892, 5921.289445266574, 5923.763049478016, 5938.346781853993, 5953.851153721148, 5710.5717071219615, 5839.7664093436215, 5850.619709718854, 5859.4140585941495, 5866.0, 5465.262189604432, 5584.46947539983, 5602.1036634138745, 5604.019296623115, 5606.943930560683, 11384.601538946097, 13138.934305328508, 13268.004899632566, 13325.667433256694, 13485.797713034312, 2015.5968806238811, 2028.6348457277684, 2045.6113338465643, 2051.9076641551164, 2292.083166733303, 9674.9516252419, 9731.610735570568, 9736.269779766475, 9749.220062394992, 10176.694699159038, 1608.7104321222175, 1657.3039323484165, 1735.5053809664312, 1775.2898840463788, 1785.3840425053336, 102273.0, 110978.44510777475, 111488.77022459505, 112263.4386828077, 113804.0, 11162.609308674157, 11181.440927953732, 11185.944070279596, 11225.382603956697, 11318.94340528292, 13180.406881690347, 13293.60417156204, 13339.19964802115, 13354.0, 13358.666033349049, 8554.401191916631, 8584.442011269373, 8589.871151932726, 8636.136386361439, 8658.87011694825, 8711.91288087111, 8721.08428614999, 8733.03936566977, 8791.956040219886, 8837.513936733541, 4279.33670281107, 4333.414988976448, 4333.804978775963, 4363.607275345171, 4376.846810361622, 1701.8638508919257, 1769.3807167491532, 1772.2556526259002, 1773.1666116925026, 1780.5103596510803, 883.7834730490943, 974.201155052864, 1008.4050410257836, 1017.1862509991977, 1018.0074427433341, 20288.985550722406, 20502.0, 21109.9445027748, 21162.576748464944, 21458.141674332852, 852.1521086518953, 930.2002707299343, 948.8829196090946, 1014.3305418423805, 1036.4662198967537, 9844.458554779412, 10278.897211027943, 10493.160547156362, 10537.789244215073, 10620.734481638021, 673170.0, 812177.0, 817634.0, 827180.0, 828759.0, 118072.0, 126275.0, 129927.0, 130473.0, 130789.0, 1205.180477275461, 1206.1918514595068, 1266.512392728806, 1268.7208814060891, 1309.705316303824, 18290.54273643116, 18753.0, 19041.714374284675, 19190.61618767589, 19257.0, 34642.61429542891, 49462.75268623634, 50042.74978625084, 50466.0, 52277.0, 55562.0, 69325.0, 69423.95864062144, 69463.65268173626, 71919.44845791116, 9578.521073946136, 10245.538950747383, 10246.38521688701, 10262.230332725225, 10279.486025698834, 16685.666286673957, 19919.402417927486, 20337.186512539334, 20762.377128686163, 21039.684404733634, 15961.600959975629, 16155.838441615904, 16280.43018494347, 16538.338466461206, 16584.253708583383, 15522.22388880574, 15568.766468503209, 15916.28376723027, 16123.758143628089, 16297.348106075624, 16617.3353065876, 16641.251143698806, 17178.828211717722, 17221.138943052545, 17226.397076102276, 9892.0, 10080.495975201356, 10120.240981926238, 10133.44266065344, 10177.0, 15889.52331430059, 16072.437464688679, 16181.919090404472, 16514.83485165133, 16657.91671041637], "unit": "ms", "name": "jquery.html", "value": 9797.631718008364}, {"lowerIsBetter": false, "replicates": [1368.33635686692, 1562.835902230266, 1668.449411694141, 1799.2712951254741, 1845.5109396010055, 7410.147832999207, 7595.392368610512, 8316.5010099394, 8684.001339845903, 8716.21554060136, 8347.207015333533, 8502.574871256427, 8536.8719469208, 8543.273821725144, 8549.70076047337, 2072.8549001569895, 2129.968050479244, 2175.2386664667397, 2377.3581133094053, 2395.281415575329, 1977.2980591889816, 2190.8904554772275, 2194.0346247651064, 2422.697162854643, 2423.6001059825107, 2328.860268383902, 2365.6806331145335, 2376.1089591403224, 2376.144587948346, 2381.57131716291, 2107.978920210809, 2129.329261282691, 2327.522857814144, 2352.847064940782, 2356.06935260572, 2169.609470295346, 2171.533120379126, 2346.1553840617535, 2384.749601291874, 2388.737238903719, 8240.381971352113, 8639.39524233304, 8646.135386461367, 8657.437266577652, 8658.264047555966, 5222.138347172712, 5299.125644268691, 5304.257403963448, 5306.2571240026045, 5307.071262529081, 3569.428891377393, 3615.475756015363, 3664.9816750916343, 3665.248624032067, 3668.192997540537, 1048.979020419595, 1054.915606751458, 1055.4353420919847, 1090.8581884355062, 1098.7088421568292, 11468.025217856492, 11471.0, 11484.94257528707, 11485.827712584234, 11495.540178392854, 4658.580727734452, 4717.43390793107, 4756.0, 4778.331033655291, 4787.688800227974, 9804.852927206097, 9807.460589667637, 9814.852777208347, 9815.803683926424, 9817.214622830157, 5318.032328038573, 5319.973400133052, 5329.040772660958, 5331.147016477423, 5332.093544097435, 4851.029794041136, 4852.927206091911, 4861.854144375674, 4863.659543831968, 4866.31871537985, 3636.4181730922924, 3708.128589781399, 3723.888283351504, 3734.626537346244, 3758.530183727034, 1167.3521195736448, 1174.365842445087, 1174.8648905375992, 1178.8467499225217, 1180.4392913366082, 1124.7469319403233, 1125.8367536707296, 1157.976840463186, 1276.393712986324, 1381.5164692357594, 7943.523388596703, 8029.357651387875, 8060.879086813702, 8104.311133553596, 8288.0, 1217.2939694976892, 1219.2379762648345, 1227.5703503773607, 1247.3513772838073, 1266.803645434959, 6044.909326360108, 6154.415330543591, 6239.719212635442, 6244.063390491463, 6311.905321420182, 10182.949085254526, 10334.594702250577, 10483.842742358871, 10510.947445262878, 10528.26302158857, 10178.287519873686, 10430.217733670004, 10456.163506919429, 10482.528286226985, 10493.9475302623, 7571.697132114764, 7655.004849369658, 8102.351811855037, 8189.631466584018, 8195.754127376189, 7955.4828936118965, 8027.237412445808, 8028.759137225892, 8035.0, 8040.557769322743, 9203.355765096647, 9233.076692330982, 9265.027172147096, 9351.438913665203, 9400.012998635046, 9250.167484926389, 9273.397229180082, 9454.905450945678, 9471.431714097176, 9583.089606487372, 6555.0, 7583.62081895892, 7587.165411804586, 7591.8861217080685, 7593.126790419173, 6955.652217389212, 8158.184181581794, 8260.132686067876, 8271.131531189138, 8276.21375969306, 7623.16145224036, 7647.082350118021, 7726.652300646597, 7768.92231077682, 7807.219278072147, 7487.962560187382, 7563.886541701989, 7605.315521603082, 7625.389968802371, 7692.7692169235015, 7082.114735658043, 7685.769426917202, 7737.11023232313, 7740.3420709240345, 7745.457817952689, 6947.513674042769, 7006.684699188447, 7016.964915175391, 7017.333353331425, 7019.2629773873, 6911.7926462206215, 6963.6866341013765, 7000.299970003162, 7003.474739394667, 7014.473914456335], "unit": "ms", "name": "mootools.html", "value": 4833.985535266977}, {"lowerIsBetter": false, "replicates": [321.55143574713276, 329.17541558396215, 331.3985117012622, 335.95800524934384, 337.3051513881405, 6377.04344348348, 6552.296402935235, 6570.868582628351, 6597.538172327927, 6655.767048153321, 5163.845084647457, 6319.620822750639, 6529.8367540811505, 6548.312427195147, 6733.0, 4865.635077369194, 4921.360223170983, 4930.704157750529, 4931.161702510564, 4936.851894443173, 4656.371389862359, 4783.449903261135, 4935.284383764352, 4940.481249468808, 4942.678725882824, 4472.396226509429, 4731.00648863739, 4787.377640906678, 4798.592119669832, 4813.350197723297, 4789.712617242942, 4802.399700037496, 4917.483664215241, 4921.040397122562, 4934.481879402683, 4162.604552567501, 4174.144300418407, 4174.3321068628875, 4180.372944058385, 4183.016991007111, 6184.226971628546, 6321.767255385202, 6332.240131184241, 6342.682865856735, 6347.270063942659, 5734.455226753494, 5768.942310576883, 5779.711014449261, 5792.420757924216, 5794.275715535558, 7007.929920700779, 7039.92960070403, 7043.929560704379, 7044.859102817915, 7065.43476521877, 4474.507804141542, 4594.74728889911, 4596.586307232332, 4713.835015774432, 4724.196886529298, 7254.818629534251, 7390.29792169743, 7393.408527317802, 7480.289372509603, 7533.773986780406, 4662.7668616569035, 4728.1252968201, 4768.0702263059065, 4771.73755443454, 4781.187198176319, 4675.555822196886, 4851.029794041136, 4857.319975203403, 4866.075445665312, 4875.317455556225, 5793.391693872167, 5810.680412577349, 5824.446677565625, 5833.854153646193, 5840.269966254218, 5713.5714821388565, 7122.821929451701, 7123.074000379917, 7126.893096603555, 7146.106736657918, 1375.9449622015006, 1468.5520916120472, 1684.8062472815539, 1702.114900251862, 1708.2654458582929, 1088.8040152772578, 1099.8570185875785, 1115.782422427635, 1122.253701288634, 1137.1300954769608, 6583.539152259296, 6596.779595774701, 6599.307072757388, 6614.0, 6619.702113404908, 7389.113306403266, 7408.555486670817, 7409.666565004588, 7419.888701669479, 7450.403967682572, 6327.3988971047675, 6565.901511477332, 6570.244421891448, 6579.769708060195, 6607.504437167232, 3875.3799392097694, 3911.100446897173, 3913.6673382762215, 3915.2952468555363, 3917.745346552522, 7368.189499155089, 7372.815679608053, 7374.668139933716, 7384.52000619958, 7391.6304184791625, 7364.484486086029, 7579.848403031909, 7583.2416758323725, 7589.58257295854, 7629.54222746637, 5870.735816888165, 7367.8894816577795, 7386.482946193715, 7394.334509894243, 7399.223081576357, 5696.487316141567, 7106.822329441805, 7345.5959922202655, 7351.191368949304, 7366.042414486083, 6746.224184218681, 7126.0, 7193.928060719326, 7217.386522145676, 7364.263573642807, 7466.8506629866015, 7476.663550140365, 7487.775366739006, 7498.850022999619, 7510.173880872991, 4821.2045012572535, 4829.782659780389, 4833.226683730586, 4835.298881662069, 4841.515848415131, 7141.571505709674, 7423.220561841145, 7425.517341372793, 7429.7399591014055, 7448.813779655552, 7094.432445404458, 7109.253528379446, 7116.822079448055, 7117.501774875709, 7135.892961605477, 5409.621326507264, 7080.4335653148655, 7083.150021997393, 7086.610236437045, 7091.787246382617, 6925.342092501204, 6939.410150137295, 6947.305269473214, 6959.89560156588, 6974.965125174342, 5754.280714910637, 7127.322904324081, 7134.8929766052515, 7142.535735177197, 7144.571325720473, 5658.773649053992, 6847.109875716125, 6963.7562685305775, 6981.685824138028, 7036.050133231948], "unit": "ms", "name": "prototype.html", "value": 5156.824555508358}, {"lowerIsBetter": false, "replicates": [697.5953946710908, 734.7465124532034, 748.3190296829886, 822.4201937633968, 837.4849467577438, 17851.464456066322, 18104.275828966827, 18128.54678633033, 18169.364072257475, 18171.545711357205, 16411.58971025722, 16541.83458165418, 16551.586210344747, 16557.66884662306, 16580.088095154762, 770.0066913681344, 771.5370777533491, 964.5611246882669, 980.5097451274363, 984.1388784813288, 720.4308596208989, 960.817444685511, 980.7989362180772, 981.4062492192228, 982.0326977926736, 1005.9547320370601, 1027.0705011964185, 1028.0, 1030.7629245273554, 1032.292879377625, 800.6877317846045, 806.8265322955564, 813.6541969662928, 1020.550957578663, 1023.2376879224951, 618.2951435363689, 670.3129292475203, 746.9514481558681, 755.5126943121655, 763.9159692433827, 13362.0, 13467.797983030263, 13486.460541578324, 13490.123141995837, 13490.39293231807, 10212.336198147097, 12195.919499796839, 12376.62870113898, 12384.133110682256, 12707.491700331975, 8628.266597339234, 10205.744856378577, 10362.222833287458, 10474.895251047468, 11087.667369978913, 3481.651834816523, 3512.2448673535314, 3522.172289511963, 3524.8942531724088, 3725.5156829612247, 76519.85220221701, 76614.61692691501, 77166.0, 78283.60858195729, 81658.0, 9533.237341012702, 9535.952320238355, 9558.95220523893, 9562.0, 9739.951300243454, 21495.247666331605, 21597.784022159893, 21709.565808684052, 21741.13035478563, 21743.23898663539, 7290.526115802456, 7423.035005449257, 7592.468527203153, 7595.620218989028, 7695.192004839411, 4081.2653722330265, 4169.437125988014, 4169.937450938239, 4203.390508376268, 4337.197618440536, 3565.286942611488, 3602.0454579536445, 3604.351216780952, 3607.873724419685, 3610.62088480711, 638.3361304243628, 646.3471893387618, 648.0408994687888, 649.0329409180288, 661.6427129350193, 481.2329107631121, 488.22616153397263, 520.274217466632, 550.5898105911042, 612.8498517863063, 8727.563621818883, 9147.63409463614, 9170.174684278447, 9348.766280843034, 9477.95742468328, 529.1929807044212, 594.6848170469658, 605.7637521366671, 626.6584711332334, 670.4535803320279, 3805.6384643458828, 3815.2941705783965, 3865.1323954289883, 3905.0, 4205.137946720914, 82977.0, 83069.58465207636, 83854.58072709598, 83963.32073358621, 99113.50443247738, 65179.0, 73655.68549415289, 78954.81567776488, 79607.60196198981, 82452.0, 57035.71482142646, 75246.71299305148, 76104.61947690225, 76271.61864190643, 76881.2311876874, 8622.353323500636, 8636.050034496326, 8649.956750216208, 8872.778180545538, 9097.317701172571, 50426.991460171324, 50774.7306317345, 51893.70265743387, 51924.990126332465, 52332.476675234284, 69581.0, 69639.0, 70443.0, 70659.93400659892, 70845.0, 10719.088877445192, 10817.0, 10959.12327013821, 11056.944715276371, 11509.482073306888, 11773.411329433666, 11870.703232419259, 12419.875801241871, 12578.30819304947, 12728.872711272768, 11103.777924441627, 11299.209055366375, 11730.472128754398, 11732.354720490455, 12310.507579696712, 11040.5031773572, 11417.429128543707, 11523.193376463567, 11657.0, 12286.569970051005, 10676.412797295912, 10712.196585256293, 11342.0, 11372.31766094037, 11949.163558550817, 5737.770489180386, 8315.792105197177, 9221.354505184841, 9657.517124143906, 10250.53872575721, 9881.110700036743, 9888.208943284664, 9917.801643967225, 9920.603175872884, 9942.204623629948], "unit": "ms", "name": "yui.html", "value": 6998.775882429293}], "name": "dromaeo_css", "value": 7664.310596837293}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 101.0, 109.0, 108.0, 107.0, 97.0, 109.0, 101.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 105.6}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 168.0, 153.0, 117.0, 138.0, 119.0, 153.0, 140.0, 117.0], "unit": "ms", "name": "audio-beat-detection", "value": 137.5}, {"lowerIsBetter": true, "replicates": [183.0, 179.0, 183.0, 183.0, 183.0, 185.0, 184.0, 187.0, 185.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [60.0, 71.0, 70.0, 73.0, 56.0, 59.0, 58.0, 71.0, 73.0, 57.0], "unit": "ms", "name": "audio-fft", "value": 64.8}, {"lowerIsBetter": true, "replicates": [87.0, 79.0, 120.0, 81.0, 109.0, 109.0, 137.0, 74.0, 76.0, 109.0], "unit": "ms", "name": "audio-oscillator", "value": 98.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 89.0, 131.0, 86.0, 86.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 90.4}, {"lowerIsBetter": true, "replicates": [137.0, 94.0, 92.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 97.3}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 88.0, 86.0, 86.0, 86.0, 84.0, 86.0, 87.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 86.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 54.0, 53.0, 52.0, 55.0, 54.0, 64.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 66.0, 64.0, 67.0, 67.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 106.0, 81.0, 80.0, 81.0, 81.0, 84.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 123.0, 125.0, 115.0, 120.0, 120.0, 114.0, 130.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [133.0, 123.0, 165.0, 170.0, 132.0, 132.0, 133.0, 135.0, 134.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 78.0, 86.0, 90.0, 91.0, 90.0, 67.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 76.0}], "name": "kraken", "value": 1405.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.64506127270042], "unit": "score", "name": "Richards", "value": 239.10044600000012}, {"lowerIsBetter": false, "replicates": [161.86468112657818], "unit": "score", "name": "DeltaBlue", "value": 408.47700399999985}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [4721.698113207547], "unit": "score", "name": "Decrypt", "value": 56.37399800199804}, {"lowerIsBetter": false, "replicates": [1709.4017094017095], "unit": "score", "name": "RayTrace", "value": 432.89356499999985}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [13675.675675675675], "unit": "score", "name": "Boyer", "value": 48.733460474308266}, {"lowerIsBetter": false, "replicates": [28000.0], "unit": "score", "name": "RegExp", "value": 32.53517857142855}, {"lowerIsBetter": false, "replicates": [760.4562737642585], "unit": "score", "name": "Splay", "value": 107.16066500000001}, {"lowerIsBetter": false, "replicates": [4559.090909090909], "unit": "score", "name": "NavierStokes", "value": 325.5034895314059}], "name": "v8_7", "value": 20155.971214862642}]} 12:35:07 INFO - RETURN: dromaeo_css: 7664.31 12:35:07 INFO - RETURN: kraken: 1405.40 12:35:07 INFO - RETURN: v8_7: 20155.97 12:35:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20155.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1405.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7664.31"}}} 12:35:07 INFO - Return code: 0 12:35:07 INFO - # TBPL SUCCESS # 12:35:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:35:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:35:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:35:07 INFO - 2015-11-23 12:35:07.579 screenresolution[1956:13684] starting screenresolution argv=screenresolution get 12:35:07 INFO - 2015-11-23 12:35:07.582 screenresolution[1956:13684] Display 0: 1600x1200x32@60 12:35:07 INFO - 2015-11-23 12:35:07.588 screenresolution[1957:13688] starting screenresolution argv=screenresolution list 12:35:07 INFO - Available Modes on Display 0 12:35:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:35:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:35:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:35:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:35:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:35:07 INFO - Intel Iris: 12:35:07 INFO - Chipset Model: Intel Iris 12:35:07 INFO - Type: GPU 12:35:07 INFO - Bus: Built-In 12:35:07 INFO - VRAM (Dynamic, Max): 1536 MB 12:35:07 INFO - Vendor: Intel (0x8086) 12:35:07 INFO - Device ID: 0x0a2e 12:35:07 INFO - Revision ID: 0x0009 12:35:07 INFO - Displays: 12:35:07 INFO - Display: 12:35:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:35:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:35:07 INFO - Display Serial Number: 1600x1200 60 12:35:07 INFO - Main Display: Yes 12:35:07 INFO - Mirror: Off 12:35:07 INFO - Online: Yes 12:35:07 INFO - Rotation: Supported 12:35:07 INFO - Return code: 0 12:35:07 INFO - Running post-action listener: _resource_record_post_action 12:35:07 INFO - Running post-run listener: _resource_record_post_run 12:35:08 INFO - Total resource usage - Wall time: 1242s; CPU: 53.0%; Read bytes: 2826240; Write bytes: 689568768; Read time: 43; Write time: 2024 12:35:08 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 333398528; Write bytes: 336274944; Read time: 26726; Write time: 620 12:35:08 INFO - run-tests - Wall time: 1212s; CPU: 53.0%; Read bytes: 2686976; Write bytes: 341816832; Read time: 40; Write time: 1369 12:35:08 INFO - Running post-run listener: _upload_blobber_files 12:35:08 INFO - Blob upload gear active. 12:35:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:35:08 INFO - Copying logs to upload dir... 12:35:08 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.665212 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-23 12:35:09.072042) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:35:09.080051) ========= 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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 build_url:https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009543 build_url: 'https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:35:09.110067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:35:09.110471) ========= 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.KtfiKm8iXY/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.GCWkjpyvEw/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005314 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:35:09.159285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:35:09.162598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:35:09.162974) ========= ========= Total master_lag: 0.34 =========