0019824: Playback pauses/stops when displays are turned off due to idling (Windows 11)

ID	Project	Category	View Status	Date Submitted	Last Update

0019824	MMW 5	Playback	public	2023-02-20 04:07	2023-02-20 15:16

Reporter	drakinite	Assigned To
Priority	urgent	Severity	minor	Reproducibility	always
Status	closed	Resolution	no change required
Product Version	5.0.4
Target Version	2024.0

Summary	0019824: Playback pauses/stops when displays are turned off due to idling (Windows 11)
Description	To reproduce on Win 11: 1. Initiate playback 2. Set Windows' power settings "turn off my screen after:" to 1 minute 3. Wait a minute for your screen(s) to turn off Audio continues playing for a few seconds, but then it stops after a bit.
Tags	No tags attached.
Attached Files	playback pauses on display shut-off.LOG (40,770 bytes) 00000001 0.00000000 [23156] MM5 [7828](R) DB: Deleting prepared query: SELECT IDGenre, GenreName FROM Genres 00000002 0.01641490 [23156] MM5 [11788](R) Going 'Worker'to make final callback 11788 00000003 0.17739710 [23156] SAStream: seeked to 589824 00000004 0.17744200 [23156] SAStream: seeked to 655360 00000005 0.17748660 [23156] SAStream: seeked to 720896 00000006 0.26048771 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 4555/107180 ms, tolerance hit: false 00000007 0.26467410 [23156] MM5 [5760](R) Still waiting for event (callstacks) : 00000008 0.26474631 [23156] MM5 [5760](R) Wait for event ID :1, delay :20000, callstack : 00000009 0.26481640 [23156] MM5 [5760](R) Wait for event ID :1, delay :60000, callstack : 00000010 0.49369529 [23692] 19/02 22:58:38.085 {INFO} [DML:HMDNormal] HMD Reporting state change: {'State':'NotDetected','IsDetected':0,'IsReady':0,'Mode':'Unknown','IsWirelessReady':0,'IsRebooting':1,'IsFirmwareOutOfDate':0} 00000011 0.51292962 [23156] MM5 [18096](R) Going 'Worker'to make final callback 18096 00000012 0.51642388 [23156] MM5 [4632](R) Going 'Worker'to make final callback 4632 00000013 1.78962398 [23156] SAStream: Seek(655360, 0) 00000014 1.78969419 [23156] SAStream: Seek(720896, 0) 00000015 1.78975201 [23156] SAStream: Seek(786432, 0) 00000016 2.26357985 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 6546/107180 ms, tolerance hit: false 00000017 2.87403321 [23156] MM5 [17188](R) Check scheduled scan/sync for: MediaMonkey Server, Last scan: 1676865468976, Interval: 30000, now: 1676865520465 00000018 2.87511230 [23156] MM5 [18684](R) BQ: Thread[18684] is executing new task now: Callstack: Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 2860 ; Col: 20 00000019 2.87511230 [23156] Script: file:///promise.js ; Func: invokeResolver ; Row: 387 ; Col: 18 00000020 2.87511230 [23156] Script: file:///promise.js ; Func: Promise ; Row: 374 ; Col: 7 00000021 2.87511230 [23156] Script: file:///helpers/mediaSync.js ; Func: setCustomSettings ; Row: 2858 ; Col: 16 00000022 2.87511230 [23156] Script: file:///helpers/mediaSync.js ; Func: checkLibraryScan ; Row: 3113 ; Col: 22 00000023 2.87526011 [23156] MM5 [17188](R) BQ: Currently running 2 threads of 30 00000024 2.87572789 [23156] MM5 [8496](R) TSharing.refreshRemoteServers starting 00000025 2.87600470 [23156] UPnP: Get servers 00000026 2.87607646 [23156] UPnP: Servers count: 0 00000027 2.87636971 [23156] MM5 [17188](R) MediaMonkey Server is not syncable now 00000028 2.92342329 [23156] MM5 [5760](R) CheckDownloadsQueue: Max: 4, in progress: 0, queued: 0, resume enabled: true 00000029 3.48295069 [23156] SAStream: Seek(720896, 0) 00000030 3.48301840 [23156] SAStream: Seek(786432, 0) 00000031 3.48307490 [23156] SAStream: Seek(851968, 0) 00000032 3.72122192 [23156] MM5 [8496](R) BQ: Thread[8496] is executing new task now: TCollections.doRefreshCollections 00000033 3.72131991 [23156] MM5 [8496](R) TCollection.getIsVisible: Classical Music, FVisibleInMainTree: 2 00000034 3.72164011 [23156] MM5 [8496](R) TCollection.checkCollectionContainsData:Classical Music, query: SELECT Songs.Id AS SongID FROM Songs WHERE Songs.TrackType in (3) LIMIT 1, res: true 00000035 3.72172999 [23156] MM5 [8496](R) TCollection.getIsVisible: Audiobooks, FVisibleInMainTree: 2 00000036 3.72194171 [23156] MM5 [8496](R) TCollection.checkCollectionContainsData:Audiobooks, query: SELECT Songs.Id AS SongID FROM Songs WHERE Songs.TrackType in (2) LIMIT 1, res: true 00000037 3.72203588 [23156] MM5 [8496](R) DB open SQL: SELECT Songs.Id AS SongID FROM Songs WHERE Songs.TrackType in (4) LIMIT 1 00000038 3.72219324 [23156] MM5 [8496](R) TCollection.getIsVisible: Video, FVisibleInMainTree: 2 00000039 3.72235513 [23156] MM5 [8496](R) TCollection.checkCollectionContainsData:Video, query: SELECT Songs.Id AS SongID FROM Songs WHERE Songs.TrackType in (5) LIMIT 1, res: true 00000040 3.72243834 [23156] MM5 [8496](R) DB open SQL: SELECT Songs.Id AS SongID FROM Songs WHERE Songs.TrackType in (6) LIMIT 1 00000041 4.25033140 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 8531/107180 ms, tolerance hit: false 00000042 5.13689184 [23156] SAStream: Seek(786432, 0) 00000043 5.13694334 [23156] SAStream: Seek(851968, 0) 00000044 5.13698578 [23156] SAStream: Seek(917504, 0) 00000045 5.89521265 [23156] MM5 [18684](R) Going 'Worker'to make final callback 18684 00000046 6.25241661 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 10535/107180 ms, tolerance hit: false 00000047 6.72240162 [23156] MM5 [8496](R) Going 'Worker'to make final callback 8496 00000048 7.01905441 [23156] SAStream: Seek(851968, 0) 00000049 7.01913977 [23156] SAStream: Seek(917504, 0) 00000050 7.01918554 [23156] SAStream: Seek(983040, 0) 00000051 8.25417709 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 12537/107180 ms, tolerance hit: false 00000052 8.63011456 [23156] SAStream: Seek(917504, 0) 00000053 8.63017654 [23156] SAStream: Seek(983040, 0) 00000054 8.63023090 [23156] SAStream: Seek(1048576, 0) 00000055 10.25756454 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 14539/107180 ms, tolerance hit: false 00000056 10.28221512 [23156] MM5 [5760](R) Still waiting for event (callstacks) : 00000057 10.28228188 [23156] MM5 [5760](R) Wait for event ID :1, delay :60000, callstack : 00000058 10.68119526 [23156] SAStream: Seek(983040, 0) 00000059 10.68125916 [23156] SAStream: Seek(1048576, 0) 00000060 10.68131638 [23156] SAStream: Seek(1114112, 0) 00000061 12.26075077 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 16544/107180 ms, tolerance hit: false 00000062 12.62597084 [23156] SAStream: Seek(1048576, 0) 00000063 12.62603664 [23156] SAStream: Seek(1114112, 0) 00000064 12.62609482 [23156] SAStream: Seek(1179648, 0) 00000065 14.26461411 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 18546/107180 ms, tolerance hit: false 00000066 14.57155037 [23156] SAStream: Seek(1114112, 0) 00000067 14.57161427 [23156] SAStream: Seek(1179648, 0) 00000068 14.57166767 [23156] SAStream: Seek(1245184, 0) 00000069 15.50546360 [23692] 19/02 22:58:53.096 {INFO} [DML:HMDNormal] HMD Reporting state change: {'State':'NotDetected','IsDetected':0,'IsReady':0,'Mode':'Unknown','IsWirelessReady':0,'IsRebooting':1,'IsFirmwareOutOfDate':0} 00000070 16.20388794 [23156] SAStream: Seek(1179648, 0) 00000071 16.20394325 [23156] SAStream: Seek(1245184, 0) 00000072 16.20399094 [23156] SAStream: Seek(1310720, 0) 00000073 16.25138092 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 20533/107180 ms, tolerance hit: false 00000074 18.17044067 [23156] SAStream: Seek(1245184, 0) 00000075 18.17050552 [23156] SAStream: Seek(1310720, 0) 00000076 18.17056084 [23156] SAStream: Seek(1376256, 0) 00000077 18.25234795 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 22535/107180 ms, tolerance hit: false 00000078 19.88653946 [23156] SAStream: Seek(1310720, 0) 00000079 19.88660812 [23156] SAStream: Seek(1376256, 0) 00000080 19.88666534 [23156] SAStream: Seek(1441792, 0) 00000081 20.25226974 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 24534/107180 ms, tolerance hit: false 00000082 20.29621124 [23156] MM5 [5760](R) Still waiting for event (callstacks) : 00000083 20.29627991 [23156] MM5 [5760](R) Wait for event ID :1, delay :60000, callstack : 00000084 21.57940102 [23156] SAStream: Seek(1376256, 0) 00000085 21.57946205 [23156] SAStream: Seek(1441792, 0) 00000086 21.57951736 [23156] SAStream: Seek(1507328, 0) 00000087 22.25495720 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 26538/107180 ms, tolerance hit: false 00000088 23.40008354 [23156] SAStream: Seek(1441792, 0) 00000089 23.40014648 [23156] SAStream: Seek(1507328, 0) 00000090 23.40020370 [23156] SAStream: Seek(1572864, 0) 00000091 24.25889206 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 28542/107180 ms, tolerance hit: false 00000092 25.38675880 [23156] SAStream: Seek(1507328, 0) 00000093 25.38682175 [23156] SAStream: Seek(1572864, 0) 00000094 25.38687706 [23156] SAStream: Seek(1638400, 0) 00000095 26.26133537 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 30543/107180 ms, tolerance hit: false 00000096 27.41571426 [23156] SAStream: Seek(1572864, 0) 00000097 27.41576576 [23156] SAStream: Seek(1638400, 0) 00000098 27.41581154 [23156] SAStream: Seek(1703936, 0) 00000099 28.25890160 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 32542/107180 ms, tolerance hit: false 00000100 29.00756836 [23156] SAStream: Seek(1638400, 0) 00000101 29.00762939 [23156] SAStream: Seek(1703936, 0) 00000102 29.00768280 [23156] SAStream: Seek(1769472, 0) 00000103 30.26009941 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 34543/107180 ms, tolerance hit: false 00000104 30.31162834 [23156] MM5 [5760](R) Still waiting for event (callstacks) : 00000105 30.31169510 [23156] MM5 [5760](R) Wait for event ID :1, delay :60000, callstack : 00000106 30.50865364 [23692] 19/02 22:59:08.100 {INFO} [DML:HMDNormal] HMD Reporting state change: {'State':'NotDetected','IsDetected':0,'IsReady':0,'Mode':'Unknown','IsWirelessReady':0,'IsRebooting':1,'IsFirmwareOutOfDate':0} 00000107 31.05862427 [23156] SAStream: Seek(1703936, 0) 00000108 31.05868721 [23156] SAStream: Seek(1769472, 0) 00000109 31.05874252 [23156] SAStream: Seek(1835008, 0) 00000110 32.24968338 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 36532/107180 ms, tolerance hit: false 00000111 32.71251297 [23156] SAStream: Seek(1769472, 0) 00000112 32.71257782 [23156] SAStream: Seek(1835008, 0) 00000113 32.71263504 [23156] SAStream: Seek(1900544, 0) 00000114 32.89892578 [23156] MM5 [17188](R) Check scheduled scan/sync for: MediaMonkey Server, Last scan: 1676865520465, Interval: 30000, now: 1676865550489 00000115 32.89996338 [23156] MM5 [23680](R) BQ: Thread[23680] is executing new task now: Callstack: Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 2860 ; Col: 20 00000116 32.89996338 [23156] Script: file:///promise.js ; Func: invokeResolver ; Row: 387 ; Col: 18 00000117 32.89996338 [23156] Script: file:///promise.js ; Func: Promise ; Row: 374 ; Col: 7 00000118 32.89996338 [23156] Script: file:///helpers/mediaSync.js ; Func: setCustomSettings ; Row: 2858 ; Col: 16 00000119 32.89996338 [23156] Script: file:///helpers/mediaSync.js ; Func: checkLibraryScan ; Row: 3113 ; Col: 22 00000120 32.90011978 [23156] MM5 [17188](R) BQ: Currently running 2 threads of 30 00000121 32.90064240 [23156] MM5 [22240](R) TSharing.refreshRemoteServers starting 00000122 32.90091705 [23156] UPnP: Get servers 00000123 32.90098572 [23156] UPnP: Servers count: 0 00000124 32.91185379 [23156] MM5 [17188](R) MediaMonkey Server is not syncable now 00000125 34.25168610 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 38535/107180 ms, tolerance hit: false 00000126 34.67953110 [23156] SAStream: Seek(1835008, 0) 00000127 34.67960358 [23156] SAStream: Seek(1900544, 0) 00000128 34.67966080 [23156] SAStream: Seek(1966080, 0) 00000129 35.90160751 [23156] MM5 [22240](R) Going 'Worker'to make final callback 22240 00000130 35.90609741 [23156] MM5 [23680](R) Going 'Worker'to make final callback 23680 00000131 36.26263809 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 40545/107180 ms, tolerance hit: false 00000132 36.39859772 [23156] SAStream: Seek(1900544, 0) 00000133 36.39866257 [23156] SAStream: Seek(1966080, 0) 00000134 36.39871979 [23156] SAStream: Seek(2031616, 0) 00000135 38.26432419 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 42547/107180 ms, tolerance hit: false 00000136 38.40613937 [23156] SAStream: Seek(1966080, 0) 00000137 38.40618896 [23156] SAStream: Seek(2031616, 0) 00000138 38.40623474 [23156] SAStream: Seek(2097152, 0) 00000139 40.25112915 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 44534/107180 ms, tolerance hit: false 00000140 40.25121689 [23156] SAStream: seeked to 2031616 00000141 40.25128174 [23156] SAStream: seeked to 2097152 00000142 40.25134277 [23156] SAStream: seeked to 2162688 00000143 40.32785034 [23156] MM5 [5760](R) Still waiting for event (callstacks) : 00000144 40.32791519 [23156] MM5 [5760](R) Wait for event ID :1, delay :60000, callstack : 00000145 41.75637054 [23156] SAStream: Seek(2097152, 0) 00000146 41.75643539 [23156] SAStream: Seek(2162688, 0) 00000147 41.75648880 [23156] SAStream: Seek(2228224, 0) 00000148 42.25507355 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 46537/107180 ms, tolerance hit: false 00000149 43.68202972 [23156] SAStream: Seek(2162688, 0) 00000150 43.68209076 [23156] SAStream: Seek(2228224, 0) 00000151 43.68214417 [23156] SAStream: Seek(2293760, 0) 00000152 44.25821304 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 48541/107180 ms, tolerance hit: false 00000153 45.49742889 [23156] SAStream: Seek(2228224, 0) 00000154 45.49752808 [23156] SAStream: seeked to 2293760 00000155 45.49760056 [23156] SAStream: seeked to 2359296 00000156 45.51279068 [23692] 19/02 22:59:23.104 {INFO} [DML:HMDNormal] HMD Reporting state change: {'State':'NotDetected','IsDetected':0,'IsReady':0,'Mode':'Unknown','IsWirelessReady':0,'IsRebooting':1,'IsFirmwareOutOfDate':0} 00000157 46.25837708 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 50540/107180 ms, tolerance hit: false 00000158 47.48351669 [23156] SAStream: Seek(2293760, 0) 00000159 47.48357391 [23156] SAStream: Seek(2359296, 0) 00000160 47.48361969 [23156] SAStream: Seek(2424832, 0) 00000161 48.25814438 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 52554/107180 ms, tolerance hit: false 00000162 49.28312683 [23156] SAStream: Seek(2359296, 0) 00000163 49.28318787 [23156] SAStream: Seek(2424832, 0) 00000164 49.28324127 [23156] SAStream: Seek(2490368, 0) 00000165 50.25780869 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 54541/107180 ms, tolerance hit: false 00000166 50.34449387 [23156] MM5 [5760](R) Still waiting for event (callstacks) : 00000167 51.20835495 [23156] SAStream: Seek(2424832, 0) 00000168 52.26071548 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 56543/107180 ms, tolerance hit: false 00000169 52.90677643 [23156] MM5 [5760](R) BQ: Currently running 1 threads of 30 00000170 52.92087936 [23156] MM5 [5760](R) New thread starting 1 00000171 52.92211151 [23156] MM5 [25232](R) Going 'AutoCalcNormalization_Var'to make final callback 25232 00000172 52.92224884 [23156] MM5 [5760](R) BQ: Task took 62672 ms, stack: TCallBacks.ProcessEventDoneCallbacks 00000173 52.92777634 [23156] MM5 [17188](R) registered task progress 1 00000174 53.10785294 [23156] SAStream: Seek(2490368, 0) 00000175 53.10791397 [23156] SAStream: Seek(2555904, 0) 00000176 53.10797119 [23156] SAStream: Seek(2621440, 0) 00000177 54.26199722 [23156] MM5 [13384](R) MemRAM: 242.1 MB, MemPrivate: 209.2 MB, MemVirtual: 701.9 MB 00000178 54.26219559 [23156] MM5 [13384](R) Allocated TSharedObject: 8146, delta: 7378 00000179 54.26225281 [23156] MM5 [13384](R) Allocated TSharedList: 252, delta: 79 00000180 54.26231766 [23156] MM5 [13384](R) Allocated TSongListData: 6470, delta: 6470 00000181 54.26237488 [23156] MM5 [13384](R) Allocated TQueryPlus: 0, delta: -3 00000182 54.26243973 [23156] MM5 [13384](R) Allocated TArtist: 0, delta: 0 00000183 54.26249695 [23156] MM5 [13384](R) Allocated TPodcast: 0, delta: 0 00000184 54.26256180 [23156] MM5 [13384](R) Allocated TPromise: 0, delta: -4 00000185 54.27170563 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 58555/107180 ms, tolerance hit: false 00000186 54.65466690 [23156] SAStream: Seek(2555904, 0) 00000187 54.65473175 [23156] SAStream: Seek(2621440, 0) 00000188 54.65478897 [23156] SAStream: Seek(2686976, 0) 00000189 55.90740585 [23156] MM5 [18864](R) Going 'Worker'to make final callback 18864 00000190 55.92242050 [23156] MM5 [5760](R) Going 'Worker'to make final callback 5760 00000191 56.02689362 [23692] 19/02 22:59:33.618 {INFO} [HW:Enumeration] Connected devices: 0 Camera(s) 00000192 56.25790787 [23156] MM5 [13384](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 60541/107180 ms, tolerance hit: false 00000193 56.53684616 [23156] SAStream: Seek(2621440, 0) 00000194 56.53690720 [23156] SAStream: Seek(2686976, 0) 00000195 56.53696823 [23156] SAStream: Seek(2752512, 0) 00000196 57.17117310 [23692] 19/02 22:59:34.762 {DEBUG} [Gamepad:Utils] Device change detected: Scanning for gamepads... 00000197 57.17309570 [23156] MM5 [17188](R) BQ: Currently running 0 threads of 10 00000198 57.17386246 [23156] MM5 [19264](R) BQ: Thread[19264] is executing new task now: TDevices.WMDeviceChangeToAll 00000199 57.17406845 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000200 57.17413712 [23156] MM5 [15216](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000201 57.17419434 [23156] MM5 [15216](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000202 57.17427063 [23156] MM5 [15216](R) BQ: Thread[15216] is executing new task now: TDevices.WMDeviceChangeToAll 00000203 57.17432785 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000204 57.17441177 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000205 57.17448425 [23156] MM5 [15216](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000206 57.17455292 [23156] MM5 [15216](R) BQ: Thread[15216] is executing new task now: TDevices.WMDeviceChangeToAll 00000207 57.18322372 [23156] WASAPI: DeviceStateChanged({0.0.0.00000000}.{bfcf50e0-9e23-42ac-bbbf-7f957f783ec5}, notpresent) 00000208 57.19028473 [23156] WASAPI: OnPropertyValueChanged({0.0.0.00000000}.{bfcf50e0-9e23-42ac-bbbf-7f957f783ec5}, {9C119480-DDC2-4954-A150-5BD240D454AD}, 1) 00000209 57.19050980 [23156] WASAPI: OnPropertyValueChanged({0.0.0.00000000}.{bfcf50e0-9e23-42ac-bbbf-7f957f783ec5}, {9C119480-DDC2-4954-A150-5BD240D454AD}, 2) 00000210 57.20326996 [23156] iPod (MM5): [19264] DeviceChange: wParam: 7, devtype: -1 00000211 57.20332718 [23156] WMDM: Queueing action id:0 00000212 57.20341873 [23156] WMDM: Looking for device changes... 00000213 58.25743866 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 62540/107180 ms, tolerance hit: false 00000214 58.39636993 [23156] SAStream: Seek(2686976, 0) 00000215 58.39644241 [23156] SAStream: Seek(2752512, 0) 00000216 58.39649963 [23156] SAStream: Seek(2818048, 0) 00000217 60.17470169 [23156] MM5 [15216](R) Going 'Worker'to make final callback 15216 00000218 60.20320511 [23156] MM5 [19264](R) Going 'Worker'to make final callback 19264 00000219 60.25600815 [23156] MM5 [9976](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 64539/107180 ms, tolerance hit: false 00000220 60.30339050 [23156] SAStream: Seek(2752512, 0) 00000221 60.30346298 [23156] SAStream: Seek(2818048, 0) 00000222 60.30352020 [23156] SAStream: Seek(2883584, 0) 00000223 60.51843262 [23692] 19/02 22:59:38.109 {INFO} [DML:HMDNormal] HMD Reporting state change: {'State':'NotDetected','IsDetected':0,'IsReady':0,'Mode':'Unknown','IsWirelessReady':0,'IsRebooting':1,'IsFirmwareOutOfDate':0} 00000224 62.02810287 [23156] SAStream: Seek(2818048, 0) 00000225 62.02817154 [23156] SAStream: Seek(2883584, 0) 00000226 62.02822876 [23156] SAStream: Seek(2949120, 0) 00000227 63.11532211 [23156] MM5 [17188](R) Check scheduled scan/sync for: MediaMonkey Server, Last scan: 1676865550490, Interval: 30000, now: 1676865580706 00000228 63.11634064 [23156] MM5 [12784](R) BQ: Thread[12784] is executing new task now: Callstack: Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 2860 ; Col: 20 00000229 63.11634064 [23156] Script: file:///promise.js ; Func: invokeResolver ; Row: 387 ; Col: 18 00000230 63.11634064 [23156] Script: file:///promise.js ; Func: Promise ; Row: 374 ; Col: 7 00000231 63.11634064 [23156] Script: file:///helpers/mediaSync.js ; Func: setCustomSettings ; Row: 2858 ; Col: 16 00000232 63.11634064 [23156] Script: file:///helpers/mediaSync.js ; Func: checkLibraryScan ; Row: 3113 ; Col: 22 00000233 63.11645889 [23156] MM5 [17188](R) BQ: Currently running 1 threads of 10 00000234 63.11697388 [23156] MM5 [6908](R) TSharing.refreshRemoteServers starting 00000235 63.11724091 [23156] UPnP: Get servers 00000236 63.11730576 [23156] UPnP: Servers count: 0 00000237 63.14012909 [23156] MM5 [17188](R) MediaMonkey Server is not syncable now 00000238 64.18615723 [23156] SAStream: Seek(2883584, 0) 00000239 64.18621826 [23156] SAStream: Seek(2949120, 0) 00000240 64.18627930 [23156] SAStream: Seek(3014656, 0) 00000241 64.26245880 [23156] MM5 [24760](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 68545/107180 ms, tolerance hit: false 00000242 66.12606812 [23156] MM5 [12784](R) Going 'Worker'to make final callback 12784 00000243 66.24963379 [23156] MM5 [14460](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 70532/107180 ms, tolerance hit: false 00000244 66.24999237 [23156] SAStream: seeked to 2949120 00000245 66.25005341 [23156] SAStream: seeked to 3014656 00000246 66.25015259 [23156] SAStream: seeked to 3080192 00000247 68.24975586 [23156] MM5 [14460](R) TFullPlayer.CheckIncreasePlayed: Percentage: 0.9, track position: 71934/107180 ms, tolerance hit: false 00000248 70.12885284 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000249 70.12953949 [23156] MM5 [10116](R) BQ: Thread[10116] is executing new task now: TDevices.WMDeviceChangeToAll 00000250 70.12968445 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000251 70.12979126 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000252 70.12985992 [23156] MM5 [26320](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000253 70.12995148 [23156] MM5 [26320](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000254 70.13001251 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000255 70.13008118 [23156] MM5 [26320](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000256 70.13014984 [23156] MM5 [26320](R) BQ: Thread[26320] is executing new task now: TDevices.WMDeviceChangeToAll 00000257 70.13191986 [23692] 19/02 22:59:47.723 {DEBUG} [Gamepad:Utils] Device change detected: Scanning for gamepads... 00000258 70.14553070 [23156] WASAPI: OnDefaultDeviceChanged(, eRender, eConsole), CurrentDeviceIDConfig={0.0.0.00000000}.{21aed06f-34d2-4dda-878e-660d042fde94}, DefaultDeviceID={0.0.0.00000000}.{21aed06f-34d2-4dda-878e-660d042fde94} 00000259 70.14587402 [23156] WASAPI: OnDefaultDeviceChanged(, eRender, eCommunications), CurrentDeviceIDConfig={0.0.0.00000000}.{21aed06f-34d2-4dda-878e-660d042fde94}, DefaultDeviceID={0.0.0.00000000}.{21aed06f-34d2-4dda-878e-660d042fde94} 00000260 70.14733887 [24720] 2023-02-19 22:59:47.738 W cue.libs.sys_vol_control: Cannot get default audio endpoint device 00000261 70.16209412 [23156] WASAPI: OnSessionDisconnected(DisconnectReasonDeviceRemoval) 00000262 70.16226959 [23156] WASAPI: OnPropertyValueChanged({0.0.0.00000000}.{21aed06f-34d2-4dda-878e-660d042fde94}, {9C119480-DDC2-4954-A150-5BD240D454AD}, 2) 00000263 70.16461945 [23156] iPod (MM5): [10116] DeviceChange: wParam: 7, devtype: -1 00000264 70.16468811 [23156] WMDM: Queueing action id:0 00000265 70.16476440 [23156] WMDM: Looking for device changes... 00000266 70.21157074 [23692] 19/02 22:59:47.802 {WARNING} [AudioDeviceSource] Unable to obtain Windows default audio output device: Element not found. (-2147023728) 00000267 70.21276855 [23692] 19/02 22:59:47.803 {WARNING} [DefaultAudioDevicePolicy] Could not find any suitable audio output device 00000268 70.22456360 [23156] WASAPI: Unplugged, resetting 00000269 70.22710419 [23156] WASAPI: No output device available. 00000270 70.22726440 [23156] WASAPI: Output thread is terminated 00000271 70.22773743 [23156] MM5 [26320](R) _Stop: started 00000272 70.22786713 [23156] MM5 [26320](R) SynchronizingAfterTagging finished 00000273 70.25543976 [23156] in_mfaudio: DecodeThread: calling Flush 2 00000274 70.25565338 [23156] in_mfaudio: DecodeThread: exit 00000275 70.25600433 [23156] in_mfaudio: Stop - calling free(pReadBuffer) 00000276 70.25610352 [23156] WASAPI: Close starts 00000277 70.25616455 [23156] MM5 [26320](R) IntOut_Close - freeing resampler 00000278 70.25630188 [23156] in_mfaudio: Stop - releasing pSource 00000279 70.25659180 [23156] in_mfaudio: Stop - pReader released 00000280 70.25666046 [23156] SAStream: calling CloseStreamAccess 00000281 70.25671387 [23156] in_mfaudio: Stop - calling SAVSADeInit 00000282 70.25677490 [23156] MM5 [26320](R) TWAPluginEngine.Stop - input plugin stopped 00000283 70.25689697 [23156] MM5 [26320](R) TInternalPlayer.Stop - finished 00000284 70.25698090 [16616] MM5 [22572](B) Received message 1024(2, 603) 00000285 70.25702667 [16616] MM5 [22572](B) Redirecting winamp message 1024(2, 603) 00000286 70.25709534 [23156] MM5 [17188](R) Player - new state: stop 00000287 70.25846100 [23156] MM5 [17188](R) last.fm: onPlaybackState stop 00000288 70.25873566 [23156] MM5 [17188](R) Player - new state: stop 00000289 70.26747131 [16616] MM5 [22572](B) WARNING: Another command in progress, inProgressCommands: 1 00000290 70.26770782 [16616] MM5 [22572](B) WARNING: Another command in progress, inProgressCommands: 2 00000291 70.37924957 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000292 70.37940216 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000293 70.37951660 [23156] MM5 [26320](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000294 70.37968445 [23156] MM5 [10116](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000295 70.39435577 [16616] MM5 [22572](B) WARNING: Another command in progress, inProgressCommands: 1 00000296 70.40986633 [16616] MM5 [22572](B) WARNING: Another command in progress, inProgressCommands: 1 00000297 70.42514038 [16616] MM5 [22572](B) WARNING: Another command in progress, inProgressCommands: 1 00000298 70.44097137 [23156] MM5 [17188](R) handleCOMr_com_player_is_playing 00000299 70.45606995 [23156] MM5 [17188](R) handleCOMr_com_player_get_is_shuffle 00000300 70.47148895 [23156] MM5 [17188](R) handleCOMr_com_player_get_is_repeat 00000301 70.48731995 [23156] MM5 [17188](R) handleCOMr_com_player_get_volume 00000302 70.50208282 [23156] MM5 [17188](R) handleCOMr_com_player_get_playback_time 00000303 73.38147736 [23156] MM5 [26320](R) Going 'Worker'to make final callback 26320 00000304 75.52543640 [23692] 19/02 22:59:47.803 {INFO} [AudioPipeline] output -> NONE 00000305 79.07540894 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000306 79.07588196 [23156] MM5 [17188](R) BQ: Currently running 1 threads of 10 00000307 79.07614136 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000308 79.07631683 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000309 79.07637024 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000310 79.28483582 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000311 79.28654480 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000312 79.28662109 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000313 79.28670502 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000314 79.28686523 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000315 79.58541870 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000316 79.58616638 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000317 79.58623505 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000318 79.58630371 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000319 79.58639526 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000320 79.91860199 [23692] 19/02 22:59:57.509 {DEBUG} [Gamepad:Utils] Device change detected: Scanning for gamepads... 00000321 79.93389130 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000322 79.93396759 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000323 79.98251343 [24720] 2023-02-19 22:59:57.573 W cue.libs.sys_vol_control: Nothing to release 00000324 79.98720551 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000325 79.98730469 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000326 79.98780060 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000327 79.98786926 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000328 79.98796844 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000329 79.98802948 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000330 79.99600220 [23692] 19/02 22:59:57.587 {DEBUG} [Gamepad:Utils] Device change detected: Scanning for gamepads... 00000331 80.04611206 [23692] 19/02 22:59:57.637 {WARNING} [DefaultAudioDevicePolicy] Could not find Rift device for input falling back to Windows default 00000332 80.13810730 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000333 80.13819885 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000334 80.13829803 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000335 80.13883209 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000336 80.13895416 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000337 80.13903046 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000338 80.13909149 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000339 80.13916016 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000340 80.13923645 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000341 80.13928223 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000342 80.13935089 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000343 80.43952942 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000344 80.44011688 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000345 80.44017792 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000346 80.44027710 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000347 80.44036102 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000348 80.49346161 [24720] 2023-02-19 22:59:58.084 I cue.devices: Manifest for device "(vid=21b4, pid=81)" not found. 00000349 80.50566864 [23692] 19/02 22:59:57.637 {INFO} [AudioPipeline] input -> Microphone (Realtek High Definition Audio) 00000350 80.50585938 [23692] 19/02 22:59:58.096 {DEBUG} [Gamepad:Utils] Device change detected: Scanning for gamepads... 00000351 80.68231964 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000352 80.68251801 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000353 80.68330383 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000354 80.68338776 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000355 80.68344116 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000356 80.68350983 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000357 80.70715332 [23692] 19/02 22:59:58.298 {DEBUG} [Gamepad:Utils] Device change detected: Scanning for gamepads... 00000358 80.77101898 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000359 80.77163696 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000360 80.77173615 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000361 80.77181244 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000362 80.78464508 [23692] 19/02 22:59:58.376 {DEBUG} [Gamepad:Utils] Device change detected: Scanning for gamepads... 00000363 80.81930542 [23692] 19/02 22:59:58.410 {WARNING} [DefaultAudioDevicePolicy] Could not find Rift device for input falling back to Windows default 00000364 80.88487244 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000365 80.88539124 [23156] MM5 [20312](R) BQ: Thread[20312] is executing new task now: TDevices.WMDeviceChangeToAll 00000366 80.88545227 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000367 80.88553619 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000368 80.88561249 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000369 80.99595642 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000370 80.99607086 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000371 80.99652863 [23156] MM5 [3612](R) BQ: Thread[3612] is executing new task now: TDevices.WMDeviceChangeToAll 00000372 80.99659729 [23156] MM5 [3612](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000373 80.99666595 [23156] MM5 [17188](R) TDevices.WMDeviceChangeToAll( wParam: 7 , lParam: 0) 00000374 80.99677277 [23156] MM5 [20312](R) TDevices.WMDeviceChangeToAll: already handled as last message 00000375 82.41538239 [23692] 19/02 22:59:58.410 {INFO} [AudioPipeline] input -> Microphone (Realtek High Definition Audio) 00000376 82.41544342 [23692] 19/02 23:00:00.006 {INFO} [RiftDML:ReportingManager] Reporting event 'oculus_etw_usb_event' 00000377 83.99813080 [23156] MM5 [3612](R) Going 'Worker'to make final callback 3612 00000378 85.60082245 [23692] 19/02 23:00:00.006 {INFO} [RiftDML:EtwReportEventInfo] oculus_etw_usb_event 00000379 85.60082245 [23692] provider_guid : ETW_PROVIDER_USB3HUB_GUID 00000380 85.60082245 [23692] process_id : 0 00000381 85.60082245 [23692] event_id : USBHUB3_ETW_EVENT_DESCRIPTOR_VALIDATION_FAILURE 00000382 85.60082245 [23692] version : 0 00000383 85.60082245 [23692] channel : 16 00000384 85.60082245 [23692] task : 9 00000385 85.60082245 [23692] opcode : 11 00000386 85.60082245 [23692] activity_guid : {9B06CAFC-415E-000C-8DAE-D49B5E41D901} 00000387 85.60082245 [23692] keyword : 4000000000004401 00000388 85.60082245 [23692] event_specific_payload : fid_HubDevice = 00005876f2a6cc88, fid_UsbDevice = 00005876f5412ab8, fid_PortNumber = 00000001, fid_NtStatus = 00000084, 00000389 85.60082245 [23692] 00000390 85.60089874 [23692] 19/02 23:00:00.006 {INFO} [RiftDML:EtwReportEventInfo] oculus_etw_usb_event 00000391 85.60089874 [23692] provider_guid : ETW_PROVIDER_USB3HUB_GUID 00000392 85.60089874 [23692] process_id : 0 00000393 85.60089874 [23692] event_id : USBHUB3_ETW_EVENT_INVALID_SERIAL_NUMBER_STRING_DESCRIPTOR 00000394 85.60089874 [23692] version : 0 00000395 85.60089874 [23692] channel : 16 00000396 85.60089874 [23692] task : 10 00000397 85.60089874 [23692] opcode : 11 00000398 85.60089874 [23692] activity_guid : {9B06CAFC-415E-000C-8DAE-D49B5E41D901} 00000399 85.60089874 [23692] keyword : 4000000000004401 00000400 85.60089874 [23692] event_specific_payload : fid_UsbDevice = 00005876f5412ab8, 00000401 85.60089874 [23692] 00000402 90.53323364 [23692] 19/02 23:00:08.124 {INFO} [DML:HMDNormal] HMD Reporting state change: {'State':'NotDetected','IsDetected':0,'IsReady':0,'Mode':'Unknown','IsWirelessReady':0,'IsRebooting':1,'IsFirmwareOutOfDate':0} 00000403 94.14021301 [23156] MM5 [17188](R) BQ: Currently running 0 threads of 10 00000404 94.14091492 [23156] MM5 [17188](R) sharing.getRemoteServers trace: Callstack: Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 1949 ; Col: 47 00000405 94.14091492 [23156] Script: file:///promise.js ; Func: invokeResolver ; Row: 387 ; Col: 18 00000406 94.14091492 [23156] Script: file:///promise.js ; Func: Promise ; Row: 374 ; Col: 7 00000407 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: _getServer ; Row: 1926 ; Col: 44 00000408 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 1987 ; Col: 18 00000409 94.14091492 [23156] Script: file:///promise.js ; Func: invokeResolver ; Row: 387 ; Col: 18 00000410 94.14091492 [23156] Script: file:///promise.js ; Func: Promise ; Row: 374 ; Col: 7 00000411 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: _checkServerIsRunning ; Row: 1986 ; Col: 14 00000412 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: syncEnabled ; Row: 1083 ; Col: 14 00000413 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: isSyncable ; Row: 2839 ; Col: 28 00000414 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: checkLibraryScan ; Row: 3115 ; Col: 27 00000415 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 3163 ; Col: 34 00000416 94.14091492 [23156] Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 3161 ; Col: 30 00000417 94.14091492 [23156] Script: file:///promise.js ; Func: invokeCallback ; Row: 399 ; Col: 19 00000418 94.14091492 [23156] Script: file:///promise.js ; Func: publish ; Row: 457 ; Col: 9 00000419 94.14091492 [23156] Script: file:///promise.js ; Func: publishFulfillment ; Row: 633 ; Col: 7 00000420 94.14091492 [23156] Script: file:///promise.js ; Func: flush ; Row: 193 ; Col: 9 00000421 94.14136505 [23156] MM5 [3636](R) BQ: Thread[3636] is executing new task now: Callstack: Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 1949 ; Col: 47 00000422 94.14136505 [23156] Script: file:///promise.js ; Func: invokeResolver ; Row: 387 ; Col: 18 00000423 94.14136505 [23156] Script: file:///promise.js ; Func: Promise ; Row: 374 ; Col: 7 00000424 94.14136505 [23156] Script: file:///helpers/mediaSync.js ; Func: _getServer ; Row: 1926 ; Col: 44 00000425 94.14136505 [23156] Script: file:///helpers/mediaSync.js ; Func: eval ; Row: 1987 ; Col: 18 00000426 94.16417694 [23156] MM5 [3636](R) DB open SQL: SELECT * FROM RemoteServers 00000427 94.16437531 [23156] UPnP: Get servers 00000428 94.16454315 [23156] MM5 [3636](R) TSharing.refreshRemoteServers finished playback pauses on display shut-off.LOG (40,770 bytes)

Fixed in build

michal 2023-02-20 09:14 developer ~0071180	According to the log audio device was disconnected. We correctly stopped playback, because no audio device was found. Please check some power management settings in Windows 11, it seems it disconnects audio devices in this situation.

drakinite 2023-02-20 14:02 developer ~0071186	Resolving as not fixable because of what Michal described, as well as the fact that I can reproduce the issue on VLC (indicating that it's not an issue with MediaMonkey at

Ludek 2023-02-20 14:38 developer ~0071187	Note that I am unable to replicate this issue.. For me MM5 continues playing even after the display is turned off (tested with WASAPI output)

drakinite 2023-02-20 15:16 developer ~0071193	Figured out that it was just an issue on my system. My USB audio device was plugged in to my monitor due to cables not being long enough, and the monitor was disabling its USB ports to save power when it's turned off. Changing to "no change required" and closing.

View Issue Details

Activities