-- Logs begin at Thu 2026-05-28 18:43:07 CST, end at Thu 2026-05-28 18:54:51 CST. --
May 28 18:53:14 volumio kernel: sd 1:0:0:0: [sda] tag#0 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN
May 28 18:53:14 volumio kernel: sd 1:0:0:0: [sda] tag#0 CDB: Read(16) 88 00 00 00 00 00 63 16 1c d0 00 00 01 00 00 00
May 28 18:53:14 volumio kernel: scsi host1: uas_eh_device_reset_handler start
May 28 18:53:14 volumio kernel: usb 3-2.2: reset SuperSpeed USB device number 3 using xhci_hcd
May 28 18:53:14 volumio kernel: scsi host1: uas_eh_device_reset_handler success
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:15 volumio volumio[869]: info: sendMpdCommand stop took 31438 milliseconds
May 28 18:53:15 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clear
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:15 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:15 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:15 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:15 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:15 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:15 volumio volumio[869]: info: sendMpdCommand status took 5 milliseconds
May 28 18:53:15 volumio volumio[869]: info: sendMpdCommand clear took 5 milliseconds
May 28 18:53:15 volumio volumio[869]: info: sendMpdCommand status took 5 milliseconds
May 28 18:53:15 volumio volumio[869]: info: sendMpdCommand status took 5 milliseconds
May 28 18:53:15 volumio volumio[869]: info: sendMpdCommand status took 4 milliseconds
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav"
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:15 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:15 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 28 18:53:15 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: No code
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 28 18:53:15 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: No code
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 28 18:53:15 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: No code
May 28 18:53:15 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:15 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:15 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:15 volumio volumio[869]: info: ------------------------------ 42ms
May 28 18:53:15 volumio volumio[869]: info: ------------------------------ 42ms
May 28 18:53:15 volumio volumio[869]: info: ------------------------------ 45ms
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:15 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:15 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:15 volumio volumio[869]: info:
May 28 18:53:15 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:15 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:45 volumio kernel: sd 1:0:0:0: [sda] tag#25 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN
May 28 18:53:45 volumio kernel: sd 1:0:0:0: [sda] tag#25 CDB: Read(16) 88 00 00 00 00 00 63 25 ac 80 00 00 00 08 00 00
May 28 18:53:45 volumio kernel: sd 1:0:0:0: [sda] tag#24 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN
May 28 18:53:45 volumio kernel: sd 1:0:0:0: [sda] tag#24 CDB: Read(16) 88 00 00 00 00 00 63 23 ed a8 00 00 01 00 00 00
May 28 18:53:45 volumio kernel: scsi host1: uas_eh_device_reset_handler start
May 28 18:53:45 volumio kernel: usb 3-2.2: reset SuperSpeed USB device number 3 using xhci_hcd
May 28 18:53:45 volumio kernel: scsi host1: uas_eh_device_reset_handler success
May 28 18:53:46 volumio volumio[869]: error: updateQueue error: null
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 30678ms
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 30677 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand add "USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav" took 30676 milliseconds
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 30637ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 30636ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 30636ms
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand play
May 28 18:53:46 volumio volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 30684ms
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPlay
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::play index undefined
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::startPlaybackTimer
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::clearAddPlayTracks USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand stop
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 23ms
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand play took 22 milliseconds
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 22ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 21ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 21ms
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand stop took 33 milliseconds
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 27 milliseconds
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 27 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 26 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 26 milliseconds
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand clear
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 5 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand clear took 4 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 3 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 2 milliseconds
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand add "USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav"
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 28 18:53:46 volumio volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 28 18:53:46 volumio volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 28 18:53:46 volumio volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: No code
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: No code
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService stop
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: No code
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 45ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 43ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 43ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 42ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 38ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 38ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 38ms
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: error: updateQueue error: null
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 63ms
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 61 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 61 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand add "USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav" took 61 milliseconds
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 27ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 26ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 26ms
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand play
May 28 18:53:46 volumio volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 28 18:53:46 volumio volumio[869]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 70ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 70ms
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces system playlist update
May 28 18:53:46 volumio volumio[869]: info: Ignoring MPD Status Update
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 40ms
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand play took 39 milliseconds
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 38ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 37ms
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 37ms
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 7 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 7 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 5 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 4 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 3 milliseconds
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 11 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 11 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 11 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 10 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 11 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 12 milliseconds
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":339,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus stop
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":339,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus play
May 28 18:53:46 volumio volumio[869]: info: Received an update from plugin. extracting info from payload
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":345,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus play
May 28 18:53:46 volumio volumio[869]: info: Received an update from plugin. extracting info from payload
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":345,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus play
May 28 18:53:46 volumio volumio[869]: info: Received an update from plugin. extracting info from payload
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":345,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus play
May 28 18:53:46 volumio volumio[869]: info: Received an update from plugin. extracting info from payload
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 34ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 59ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 58ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 55ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 54ms
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info:
May 28 18:53:46 volumio volumio[869]: ---------------------------- MPD announces state update: player
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::getState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand status
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 39 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 6 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand status took 5 milliseconds
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseState
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":350,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus play
May 28 18:53:46 volumio volumio[869]: info: Received an update from plugin. extracting info from payload
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 75ms
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 66 milliseconds
May 28 18:53:46 volumio volumio[869]: info: sendMpdCommand playlistinfo took 66 milliseconds
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: verbose: ControllerMpd::parseTrackInfo
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":407,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus play
May 28 18:53:46 volumio volumio[869]: info: Received an update from plugin. extracting info from payload
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ControllerMpd::pushState
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::servicePushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: verbose: STATE SERVICE {"status":"play","position":0,"seek":407,"duration":222,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"12. 12.新贵妃醉酒.wav","artist":null,"album":null,"uri":"USB/音乐/发烧人声 24bit 96khz/乌兰图雅 《发烧翻唱》[WAV] 24bit 96khz/12. 12.新贵妃醉酒.wav","trackType":"wav"}
May 28 18:53:46 volumio volumio[869]: verbose: CURRENT POSITION 31
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState stateService play
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::syncState currentStatus play
May 28 18:53:46 volumio volumio[869]: info: Received an update from plugin. extracting info from payload
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: CoreStateMachine::pushState
May 28 18:53:46 volumio volumio[869]: info: CorePlayQueue::getTrack 31
May 28 18:53:46 volumio volumio[869]: info: CoreCommandRouter::volumioPushState
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 103ms
May 28 18:53:46 volumio volumio[869]: info: ------------------------------ 104ms
May 28 18:54:03 volumio ntpd[858]: 162.159.200.1 local addr 192.168.12.58 ->
May 28 18:54:04 volumio ntpd[858]: 5.79.108.34 local addr 192.168.12.58 ->
May 28 18:54:18 volumio kernel: sd 1:0:0:0: [sda] tag#2 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN
May 28 18:54:18 volumio kernel: sd 1:0:0:0: [sda] tag#2 CDB: Read(16) 88 00 00 00 00 00 63 8e 78 b0 00 00 01 00 00 00
May 28 18:54:18 volumio kernel: sd 1:0:0:0: [sda] tag#1 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN
May 28 18:54:18 volumio kernel: sd 1:0:0:0: [sda] tag#1 CDB: Read(16) 88 00 00 00 00 00 63 8e 77 b0 00 00 01 00 00 00
May 28 18:54:18 volumio kernel: scsi host1: uas_eh_device_reset_handler start
May 28 18:54:18 volumio kernel: usb 3-2.2: reset SuperSpeed USB device number 3 using xhci_hcd
May 28 18:54:18 volumio kernel: scsi host1: uas_eh_device_reset_handler success
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:18 volumio volumio[869]: Upnp client error: Error: This socket has been ended by the other party
May 28 18:54:51 volumio kernel: sd 1:0:0:0: [sda] tag#0 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN
May 28 18:54:51 volumio kernel: sd 1:0:0:0: [sda] tag#0 CDB: Read(16) 88 00 00 00 00 00 63 d1 11 30 00 00 01 00 00 00
May 28 18:54:51 volumio kernel: scsi host1: uas_eh_device_reset_handler start
May 28 18:54:51 volumio kernel: usb 3-2.2: reset SuperSpeed USB device number 3 using xhci_hcd
May 28 18:54:51 volumio kernel: scsi host1: uas_eh_device_reset_handler success
May 28 18:54:51 volumio volumio[869]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 18:54:51 volumio volumio[869]: Error: connect ETIMEDOUT 185.60.216.50:443
May 28 18:54:51 volumio volumio[869]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
May 28 18:54:51 volumio volumio[869]: errno: -110,
May 28 18:54:51 volumio volumio[869]: code: 'ETIMEDOUT',
May 28 18:54:51 volumio volumio[869]: syscall: 'connect',
May 28 18:54:51 volumio volumio[869]: address: '185.60.216.50',
May 28 18:54:51 volumio volumio[869]: port: 443
May 28 18:54:51 volumio volumio[869]: }
May 28 18:54:51 volumio volumio[869]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 18:54:51 volumio sudo[2617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-28 18:53
May 28 18:54:51 volumio sudo[2617]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"