Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Dynamic memory balancing stopped working (in v4.2.3 after restore) #9669

Closed
matheusd opened this issue Dec 26, 2024 · 2 comments
Closed

Dynamic memory balancing stopped working (in v4.2.3 after restore) #9669

matheusd opened this issue Dec 26, 2024 · 2 comments
Labels
P: default Priority: default. Default priority for new issues, to be replaced given sufficient information. R: duplicate Resolution: Another issue exists that is very similar to or subsumes this one. T: bug Type: bug report. A problem or defect resulting in unintended behavior in something that exists.

Comments

@matheusd
Copy link

Qubes OS release

4.2.3 (recently installed, fully updated)

Brief summary

Installed a fresh copy of 4.2.3, restored some backups (from 4.1 if it's any relevant) and was working through my new machine setup procedure (setting up new VMs, testing restored VMs, etc).

At some point, dynamic memory balance stopped working and it hasn't returned, even after a full system restart.

By "dynamic memory balance stopped working", I mean that AppVMs with the "Include in memory balancing" option checked won't have their memory dynamically increased when needed. This was definitely working at some point during my setup, but then it stopped working for all VMs.

I have increased the verbosity of qmemman (log-level = 10 in qmemman.conf) but I don't see anything wrong. Below are logs of lauching a new VM running Firefox. Usually, this VM would start with 600MB, but quickly grow to 2000MB to accommodate Firefox, but it now just remains at 600MB (or whatever I set as the initial memory.

qmemman logs at log-level 10
Dec 26 15:00:12 dom0 qmemman.daemon.reqhandler[2381]: data=b'664207360'
Dec 26 15:00:12 dom0 qmemman.daemon.reqhandler[2381]: acquiring global_lock
Dec 26 15:00:12 dom0 qmemman.daemon.reqhandler[2381]: global_lock acquired
Dec 26 15:00:12 dom0 qmemman.systemstate[2381]: do_balloon(memsize=664207360)
Dec 26 15:00:12 dom0 qmemman.systemstate[2381]: niter= 0
Dec 26 15:00:12 dom0 qmemman.systemstate[2381]: xenfree=24007853331
Dec 26 15:00:12 dom0 qmemman.systemstate[2381]: inhibit_balloon_up()
Dec 26 15:00:12 dom0 qmemman.daemon.reqhandler[2381]: resp=b'OK\n'
Dec 26 15:00:12 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/0/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='0'))
Dec 26 15:00:12 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='0')
Dec 26 15:00:12 dom0 qmemman.daemon.xswatcher[2381]: acquiring global_lock
Dec 26 15:00:14 dom0 qmemman.daemon.reqhandler[2381]: data=b''
Dec 26 15:00:14 dom0 qmemman.daemon.reqhandler[2381]: client disconnected, resuming membalance
Dec 26 15:00:14 dom0 qmemman.daemon.reqhandler[2381]: global_lock released
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock acquired
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: domain_list_changed(only_refresh=True)
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: curr=['0', '1', '2', '3', '4', '5', '6', '7', '8', '9', '13']
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: add_domain(id='13')
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: refresh_meminfo(domid=0, untrusted_meminfo_key=b'1315476')
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: do_balance()
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance(xen_free_memory=23277815156, domain_dictionary={'0': {'memory_current': 4278190080, 'memory_actual': 4294967296, 'memory_maximum': 4294967296, 'mem_used': 1347047424, 'id': '0', 'last_target': 4294967296, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '1': {'memory_current': 428912640, 'memory_actual': 428912640, 'memory_maximum': 445644800, 'mem_used': None, 'id': '1', 'last_target': 428867584, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '2': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '2', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '3': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '3', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '4': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '4', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '5': {'memory_current': 524353536, 'memory_actual': 524353536, 'memory_maximum': 1048576000, 'mem_used': None, 'id': '5', 'last_target': 524288000, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '6': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '6', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '7': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '7', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '8': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 2097152000, 'mem_used': None, 'id': '8', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '9': {'memory_current': 419495936, 'memory_actual': 419495936, 'memory_maximum': 419430400, 'mem_used': None, 'id': '9', 'last_target': 419430400, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '13': {'memory_current': 629215232, 'memory_actual': 629215232, 'memory_maximum': 629145600, 'mem_used': None, 'id': '13', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}})
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance_when_enough_memory(xen_free_memory=23277815156, total_mem_pref=2101161651, total_available_memory=25471620801)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant(memset_reqs=[('0', 4294967296)], xenfree=23330243956)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant return True
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: dom '0' act=4294967296 pref=2101161651 last_target=4294967296
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: xenfree=23330243956 memset_reqs=[('0', 4294967296)]
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: mem-set domain 0 to 4294967296
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock released
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/0/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='0'))
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='0')
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: acquiring global_lock
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock acquired
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: refresh_meminfo(domid=0, untrusted_meminfo_key=b'1287460')
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: do_balance()
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance(xen_free_memory=23277815156, domain_dictionary={'0': {'memory_current': 4278190080, 'memory_actual': 4294967296, 'memory_maximum': 4294967296, 'mem_used': 1318359040, 'id': '0', 'last_target': 4294967296, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '1': {'memory_current': 428912640, 'memory_actual': 428912640, 'memory_maximum': 445644800, 'mem_used': None, 'id': '1', 'last_target': 428867584, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '2': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '2', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '3': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '3', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '4': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '4', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '5': {'memory_current': 524353536, 'memory_actual': 524353536, 'memory_maximum': 1048576000, 'mem_used': None, 'id': '5', 'last_target': 524288000, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '6': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '6', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '7': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '7', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '8': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 2097152000, 'mem_used': None, 'id': '8', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '9': {'memory_current': 419495936, 'memory_actual': 419495936, 'memory_maximum': 419430400, 'mem_used': None, 'id': '9', 'last_target': 419430400, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '13': {'memory_current': 629215232, 'memory_actual': 629215232, 'memory_maximum': 629145600, 'mem_used': None, 'id': '13', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}})
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance_when_enough_memory(xen_free_memory=23277815156, total_mem_pref=2063866752, total_available_memory=25508915700)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant(memset_reqs=[('0', 4294967296)], xenfree=23330243956)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant return True
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: dom '0' act=4294967296 pref=2063866752 last_target=4294967296
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: xenfree=23330243956 memset_reqs=[('0', 4294967296)]
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: mem-set domain 0 to 4294967296
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock released
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/0/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='0'))
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='0')
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: acquiring global_lock
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock acquired
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: refresh_meminfo(domid=0, untrusted_meminfo_key=b'1287460')
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: do_balance()
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance(xen_free_memory=23277815156, domain_dictionary={'0': {'memory_current': 4278190080, 'memory_actual': 4294967296, 'memory_maximum': 4294967296, 'mem_used': 1318359040, 'id': '0', 'last_target': 4294967296, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '1': {'memory_current': 428912640, 'memory_actual': 428912640, 'memory_maximum': 445644800, 'mem_used': None, 'id': '1', 'last_target': 428867584, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '2': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '2', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '3': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '3', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '4': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '4', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '5': {'memory_current': 524353536, 'memory_actual': 524353536, 'memory_maximum': 1048576000, 'mem_used': None, 'id': '5', 'last_target': 524288000, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '6': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '6', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '7': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '7', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '8': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 2097152000, 'mem_used': None, 'id': '8', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '9': {'memory_current': 419495936, 'memory_actual': 419495936, 'memory_maximum': 419430400, 'mem_used': None, 'id': '9', 'last_target': 419430400, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '13': {'memory_current': 629215232, 'memory_actual': 629215232, 'memory_maximum': 629145600, 'mem_used': None, 'id': '13', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}})
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance_when_enough_memory(xen_free_memory=23277815156, total_mem_pref=2063866752, total_available_memory=25508915700)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant(memset_reqs=[('0', 4294967296)], xenfree=23330243956)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant return True
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: dom '0' act=4294967296 pref=2063866752 last_target=4294967296
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: xenfree=23330243956 memset_reqs=[('0', 4294967296)]
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: mem-set domain 0 to 4294967296
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock released
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('@introduceDomain', WatchType(func=<function XSWatcher.domain_list_changed at 0x77336b0f3740>, param=False))
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: domain_list_changed(only_refresh=False)
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: acquiring global_lock
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock acquired
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: curr=['0', '1', '2', '3', '4', '5', '6', '7', '8', '9', '13']
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: global_lock released
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: do_balance()
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance(xen_free_memory=23277815156, domain_dictionary={'0': {'memory_current': 4278190080, 'memory_actual': 4294967296, 'memory_maximum': 4294967296, 'mem_used': 1318359040, 'id': '0', 'last_target': 4294967296, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '1': {'memory_current': 428912640, 'memory_actual': 428912640, 'memory_maximum': 445644800, 'mem_used': None, 'id': '1', 'last_target': 428867584, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '2': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '2', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '3': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '3', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '4': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '4', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '5': {'memory_current': 524353536, 'memory_actual': 524353536, 'memory_maximum': 1048576000, 'mem_used': None, 'id': '5', 'last_target': 524288000, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '6': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '6', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '7': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '7', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '8': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 2097152000, 'mem_used': None, 'id': '8', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '9': {'memory_current': 419495936, 'memory_actual': 419495936, 'memory_maximum': 419430400, 'mem_used': None, 'id': '9', 'last_target': 419430400, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '13': {'memory_current': 629215232, 'memory_actual': 629215232, 'memory_maximum': 629145600, 'mem_used': None, 'id': '13', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}})
Dec 26 15:00:14 dom0 qmemman.daemon.algo[2381]: balance_when_enough_memory(xen_free_memory=23277815156, total_mem_pref=2063866752, total_available_memory=25508915700)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant(memset_reqs=[('0', 4294967296)], xenfree=23330243956)
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: is_balance_req_significant return True
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: dom '0' act=4294967296 pref=2063866752 last_target=4294967296
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: stat: xenfree=23330243956 memset_reqs=[('0', 4294967296)]
Dec 26 15:00:14 dom0 qmemman.systemstate[2381]: mem-set domain 0 to 4294967296
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/13/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='13'))
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='13')
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/13/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='13'))
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='13')
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/13/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='13'))
Dec 26 15:00:14 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='13')
Dec 26 15:00:28 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/0/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='0'))
Dec 26 15:00:28 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='0')
Dec 26 15:00:28 dom0 qmemman.daemon.xswatcher[2381]: acquiring global_lock
Dec 26 15:00:28 dom0 qmemman.daemon.xswatcher[2381]: global_lock acquired
Dec 26 15:00:28 dom0 qmemman.systemstate[2381]: refresh_meminfo(domid=0, untrusted_meminfo_key=b'1322496')
Dec 26 15:00:28 dom0 qmemman.systemstate[2381]: do_balance()
Dec 26 15:00:28 dom0 qmemman.daemon.algo[2381]: balance(xen_free_memory=23277221774, domain_dictionary={'0': {'memory_current': 4278190080, 'memory_actual': 4294967296, 'memory_maximum': 4294967296, 'mem_used': 1354235904, 'id': '0', 'last_target': 4294967296, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '1': {'memory_current': 428912640, 'memory_actual': 428912640, 'memory_maximum': 445644800, 'mem_used': None, 'id': '1', 'last_target': 428867584, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '2': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '2', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '3': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '3', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '4': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '4', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '5': {'memory_current': 524353536, 'memory_actual': 524353536, 'memory_maximum': 1048576000, 'mem_used': None, 'id': '5', 'last_target': 524288000, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '6': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '6', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '7': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '7', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '8': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 2097152000, 'mem_used': None, 'id': '8', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '9': {'memory_current': 419495936, 'memory_actual': 419495936, 'memory_maximum': 419430400, 'mem_used': None, 'id': '9', 'last_target': 419430400, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '13': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 6291456000, 'mem_used': None, 'id': '13', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}})
Dec 26 15:00:28 dom0 qmemman.daemon.algo[2381]: balance_when_enough_memory(xen_free_memory=23277221774, total_mem_pref=2110506675, total_available_memory=25461682395)
Dec 26 15:00:28 dom0 qmemman.systemstate[2381]: is_balance_req_significant(memset_reqs=[('0', 4294967296)], xenfree=23329650574)
Dec 26 15:00:28 dom0 qmemman.systemstate[2381]: is_balance_req_significant return True
Dec 26 15:00:28 dom0 qmemman.systemstate[2381]: stat: dom '0' act=4294967296 pref=2110506675 last_target=4294967296
Dec 26 15:00:28 dom0 qmemman.systemstate[2381]: stat: xenfree=23329650574 memset_reqs=[('0', 4294967296)]
Dec 26 15:00:28 dom0 qmemman.systemstate[2381]: mem-set domain 0 to 4294967296
Dec 26 15:00:28 dom0 qmemman.daemon.xswatcher[2381]: global_lock released
Shutting down the same VM
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('@releaseDomain', WatchType(func=<function XSWatcher.domain_list_changed at 0x77336b0f3740>, param=False))
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: domain_list_changed(only_refresh=False)
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: acquiring global_lock
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: global_lock acquired
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: curr=['0', '1', '2', '3', '4', '5', '6', '7', '8', '9', '13']
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: global_lock released
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: do_balance()
Dec 26 15:00:54 dom0 qmemman.daemon.algo[2381]: balance(xen_free_memory=23277197389, domain_dictionary={'0': {'memory_current': 4278190080, 'memory_actual': 4294967296, 'memory_maximum': 4294967296, 'mem_used': 1354235904, 'id': '0', 'last_target': 4294967296, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '1': {'memory_current': 428912640, 'memory_actual': 428912640, 'memory_maximum': 445644800, 'mem_used': None, 'id': '1', 'last_target': 428867584, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '2': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '2', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '3': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '3', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '4': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '4', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '5': {'memory_current': 524353536, 'memory_actual': 524353536, 'memory_maximum': 1048576000, 'mem_used': None, 'id': '5', 'last_target': 524288000, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '6': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '6', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '7': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '7', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '8': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 2097152000, 'mem_used': None, 'id': '8', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '9': {'memory_current': 419495936, 'memory_actual': 419495936, 'memory_maximum': 419430400, 'mem_used': None, 'id': '9', 'last_target': 419430400, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '13': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 6291456000, 'mem_used': None, 'id': '13', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}})
Dec 26 15:00:54 dom0 qmemman.daemon.algo[2381]: balance_when_enough_memory(xen_free_memory=23277197389, total_mem_pref=2110506675, total_available_memory=25461658010)
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: is_balance_req_significant(memset_reqs=[('0', 4294967296)], xenfree=23329626189)
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: is_balance_req_significant return True
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: stat: dom '0' act=4294967296 pref=2110506675 last_target=4294967296
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: stat: xenfree=23329626189 memset_reqs=[('0', 4294967296)]
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: mem-set domain 0 to 4294967296
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('/local/domain/13/memory/meminfo', WatchType(func=<function XSWatcher.meminfo_changed at 0x77336b0f37e0>, param='13'))
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: meminfo_changed(domain_id='13')
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: watch_loop result=('@releaseDomain', WatchType(func=<function XSWatcher.domain_list_changed at 0x77336b0f3740>, param=False))
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: domain_list_changed(only_refresh=False)
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: acquiring global_lock
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: global_lock acquired
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: curr=['0', '1', '2', '3', '4', '5', '6', '7', '8', '9']
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: del_domain(id='13')
Dec 26 15:00:54 dom0 qmemman.daemon.xswatcher[2381]: global_lock released
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: do_balance()
Dec 26 15:00:54 dom0 qmemman.daemon.algo[2381]: balance(xen_free_memory=23955420467, domain_dictionary={'0': {'memory_current': 4278190080, 'memory_actual': 4294967296, 'memory_maximum': 4294967296, 'mem_used': 1354235904, 'id': '0', 'last_target': 4294967296, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '1': {'memory_current': 428912640, 'memory_actual': 428912640, 'memory_maximum': 445644800, 'mem_used': None, 'id': '1', 'last_target': 428867584, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '2': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '2', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '3': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '3', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '4': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '4', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '5': {'memory_current': 524353536, 'memory_actual': 524353536, 'memory_maximum': 1048576000, 'mem_used': None, 'id': '5', 'last_target': 524288000, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '6': {'memory_current': 402698240, 'memory_actual': 402698240, 'memory_maximum': 419430400, 'mem_used': None, 'id': '6', 'last_target': 402653184, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '7': {'memory_current': 150994944, 'memory_actual': 150994944, 'memory_maximum': 150994944, 'mem_used': None, 'id': '7', 'last_target': 150994944, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': False}, '8': {'memory_current': 629211136, 'memory_actual': 629211136, 'memory_maximum': 2097152000, 'mem_used': None, 'id': '8', 'last_target': 629145600, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}, '9': {'memory_current': 419495936, 'memory_actual': 419495936, 'memory_maximum': 419430400, 'mem_used': None, 'id': '9', 'last_target': 419430400, 'use_hoplug': False, 'no_progress': False, 'slow_memset_react': False, 'use_hotplug': True}})
Dec 26 15:00:54 dom0 qmemman.daemon.algo[2381]: balance_when_enough_memory(xen_free_memory=23955420467, total_mem_pref=2110506675, total_available_memory=26139881088)
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: is_balance_req_significant(memset_reqs=[('0', 4294967296)], xenfree=24007849267)
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: is_balance_req_significant return True
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: stat: dom '0' act=4294967296 pref=2110506675 last_target=4294967296
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: stat: xenfree=24007849267 memset_reqs=[('0', 4294967296)]
Dec 26 15:00:54 dom0 qmemman.systemstate[2381]: mem-set domain 0 to 4294967296

Steps to reproduce

Not sure yet.

Expected behavior

Dynamic memory balacing should work.

Actual behavior

Dynamic memory balancing not working.

@matheusd matheusd added P: default Priority: default. Default priority for new issues, to be replaced given sufficient information. T: bug Type: bug report. A problem or defect resulting in unintended behavior in something that exists. labels Dec 26, 2024
@marmarek
Copy link
Member

Duplicate of #9663

@marmarek marmarek marked this as a duplicate of #9663 Dec 26, 2024
@marmarek marmarek added the R: duplicate Resolution: Another issue exists that is very similar to or subsumes this one. label Dec 26, 2024
Copy link

This issue has been closed as a "duplicate." This means that another issue exists that is very similar to or subsumes this one. If any useful information on this issue is not already present on the other issue, please add it in a comment on the other issue. Here are some common cases of duplicate issues:

  • The other issue is closed. The other issue being closed does not prevent this issue from duplicating it. We will examine the closed issue and, if appropriate, reopen it.
  • The other issue is for a different Qubes release. We usually maintain only one issue for all affected Qubes releases.
  • The other issue is very old. The mere age of an issue is not, by itself, a relevant factor when determining duplicates.

By default, the newer issue will be closed in favor of the older issue. However, we make exceptions when we determine that it would be significantly more useful to keep the newer issue open instead of the older one.

We respect the time and effort you have taken to file this issue, and we understand that this outcome may be unsatisfying. Please accept our sincere apologies and know that we greatly value your participation and membership in the Qubes community.

If anyone reading this believes that this issue was closed in error or that the resolution of "duplicate" is not accurate, please leave a comment below saying so, and we will review this issue again. For more information, see How issues get closed.

@github-actions github-actions bot closed this as not planned Won't fix, can't repro, duplicate, stale Dec 26, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
P: default Priority: default. Default priority for new issues, to be replaced given sufficient information. R: duplicate Resolution: Another issue exists that is very similar to or subsumes this one. T: bug Type: bug report. A problem or defect resulting in unintended behavior in something that exists.
Projects
None yet
Development

No branches or pull requests

2 participants