Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.038507, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.038830, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.039043, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.039262, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.41, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.039485, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (6) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.41, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.041183, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (7) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.42, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.041735, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (8) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.42, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.113259, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (9) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.113590, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (10) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.113817, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (11) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.41, reporting an IP address of 192.168.0.42. Apr 11 09:33:03 volumio nmbd[1078]: [2026/04/11 09:33:03.115992, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 11 09:33:03 volumio nmbd[1078]: query_name_response: Multiple (12) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>. Apr 11 09:33:03 volumio nmbd[1078]: This response was from IP 192.168.0.42, reporting an IP address of 192.168.0.42. Apr 11 09:33:19 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Apr 11 09:33:20 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Apr 11 09:33:20 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Apr 11 09:33:49 volumio volumio5-onboarding[2058]: time=2026-04-11T09:33:49.319+08:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.66:50798 Apr 11 09:33:52 volumio volumio[3153]: verbose: New Socket.io Connection to 192.168.0.202 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 16; V2366GA Build/BP2A.250605.031.A3_MOD1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 11 09:33:52 volumio volumio[3153]: verbose: New Socket.io Connection to 192.168.0.202 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 16; V2366GA Build/BP2A.250605.031.A3_MOD1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 11 09:33:53 volumio volumio[3153]: info: CoreCommandRouter::volumioGetState Apr 11 09:33:53 volumio volumio[3153]: info: CorePlayQueue::getTrack 0 Apr 11 09:33:54 volumio volumio5-onboarding[2058]: time=2026-04-11T09:33:54.772+08:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.66:50798 Apr 11 09:33:54 volumio volumio5-onboarding[2058]: time=2026-04-11T09:33:54.772+08:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.66:50798 Apr 11 09:33:54 volumio volumio5-onboarding[2058]: time=2026-04-11T09:33:54.784+08:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.66:50820 Apr 11 09:33:55 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 11 09:33:55 volumio volumio[3153]: info: Listing playlists Apr 11 09:33:55 volumio volumio[3153]: info: CoreCommandRouter::volumioGetQueue Apr 11 09:33:55 volumio volumio[3153]: info: CoreStateMachine::getQueue Apr 11 09:33:55 volumio volumio[3153]: info: CorePlayQueue::getQueue Apr 11 09:33:55 volumio volumio[3153]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 09:33:55 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 09:34:04 volumio ntpd[1008]: PROTO: 101.35.255.34 unlink local addr 192.168.0.202 -> Apr 11 09:34:04 volumio volumio[3153]: info: CoreCommandRouter::volumioNext Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::next Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::stop Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::play index undefined Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 09:34:04 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::startPlaybackTimer Apr 11 09:34:04 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:04 volumio volumio[3153]: verbose: ControllerMpd::clearAddPlayTracks NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf Apr 11 09:34:04 volumio volumio[3153]: info: Setting Volume to 100 automatically for DSD Apr 11 09:34:04 volumio volumio[3153]: info: VolumeController::SetAlsaVolume100 Apr 11 09:34:04 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:04 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:04 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 09:34:04 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:04 volumio volumio[3153]: info: CoreStateMachine::updateTrackBlock Apr 11 09:34:04 volumio volumio[3153]: info: CorePlayQueue::getTrackBlock Apr 11 09:34:04 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:04.943+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 11 09:34:04 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:04.946+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:04 volumio volumio[3153]: info: sendMpdCommand stop took 38 milliseconds Apr 11 09:34:04 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 09:34:04 volumio volumio[3153]: info: Apr 11 09:34:04 volumio volumio[3153]: ---------------------------- MPD announces system playlist update Apr 11 09:34:04 volumio volumio[3153]: info: Ignoring MPD Status Update Apr 11 09:34:04 volumio volumio[3153]: info: sendMpdCommand clear took 10 milliseconds Apr 11 09:34:04 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand add "NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" Apr 11 09:34:04 volumio volumio[3153]: info: Apr 11 09:34:04 volumio volumio[3153]: ---------------------------- MPD announces system playlist update Apr 11 09:34:04 volumio volumio[3153]: info: Ignoring MPD Status Update Apr 11 09:34:04 volumio volumio[3153]: info: Apr 11 09:34:04 volumio volumio[3153]: ---------------------------- MPD announces system playlist update Apr 11 09:34:04 volumio volumio[3153]: info: Ignoring MPD Status Update Apr 11 09:34:04 volumio volumio[3153]: error: updateQueue error: null Apr 11 09:34:04 volumio volumio[3153]: info: Apr 11 09:34:04 volumio volumio[3153]: ---------------------------- MPD announces system playlist update Apr 11 09:34:04 volumio volumio[3153]: info: Ignoring MPD Status Update Apr 11 09:34:04 volumio volumio[3153]: info: ------------------------------ 14ms Apr 11 09:34:04 volumio volumio[3153]: info: sendMpdCommand add "NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" took 11 milliseconds Apr 11 09:34:04 volumio volumio[3153]: info: ------------------------------ 10ms Apr 11 09:34:04 volumio volumio[3153]: info: ------------------------------ 9ms Apr 11 09:34:04 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand play Apr 11 09:34:04 volumio volumio[3153]: info: Apr 11 09:34:04 volumio volumio[3153]: ---------------------------- MPD announces system playlist update Apr 11 09:34:04 volumio volumio[3153]: info: Ignoring MPD Status Update Apr 11 09:34:04 volumio volumio[3153]: info: Apr 11 09:34:04 volumio volumio[3153]: ---------------------------- MPD announces system playlist update Apr 11 09:34:04 volumio volumio[3153]: info: Ignoring MPD Status Update Apr 11 09:34:04 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 09:34:04 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 09:34:04 volumio volumio[3153]: info: Discovery: Getting this device information Apr 11 09:34:04 volumio volumio[3153]: info: CoreCommandRouter::volumioGetState Apr 11 09:34:04 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:04 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 09:34:05 volumio volumio[3153]: info: ------------------------------ 679ms Apr 11 09:34:05 volumio volumio[3153]: info: sendMpdCommand play took 677 milliseconds Apr 11 09:34:05 volumio volumio[3153]: info: ------------------------------ 676ms Apr 11 09:34:05 volumio volumio[3153]: info: ------------------------------ 676ms Apr 11 09:34:07 volumio volumio[3153]: verbose: New Socket.io Connection to 192.168.0.202:3000 from 192.168.0.66 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Apr 11 09:34:07 volumio volumio[3153]: info: Apr 11 09:34:07 volumio volumio[3153]: ---------------------------- MPD announces state update: player Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::getState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand status Apr 11 09:34:07 volumio volumio[3153]: info: Apr 11 09:34:07 volumio volumio[3153]: ---------------------------- MPD announces state update: player Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::getState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand status Apr 11 09:34:07 volumio volumio[3153]: info: Apr 11 09:34:07 volumio volumio[3153]: ---------------------------- MPD announces state update: player Apr 11 09:34:07 volumio volumio[3153]: info: Apr 11 09:34:07 volumio volumio[3153]: ---------------------------- MPD announces state update: player Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::getState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand status Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand status took 7 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::getState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand status Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 11 09:34:07 volumio volumio[3153]: info: Apr 11 09:34:07 volumio volumio[3153]: ---------------------------- MPD announces state update: player Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::getState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand status Apr 11 09:34:07 volumio volumio[3153]: info: Apr 11 09:34:07 volumio volumio[3153]: ---------------------------- MPD announces state update: player Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::getState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand status Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand status took 418 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand status took 414 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand status took 414 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand playlistinfo took 412 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand status took 6 milliseconds Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseTrackInfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::servicePushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2115,"duration":300,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Blue And Sentimental","artist":"Teddy Edwards","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf","trackType":"dsf"} Apr 11 09:34:07 volumio volumio[3153]: verbose: CURRENT POSITION 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState stateService play Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState currentStatus stop Apr 11 09:34:07 volumio volumio[3153]: info: ------------------------------ 442ms Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand status took 29 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand playlistinfo took 21 milliseconds Apr 11 09:34:07 volumio volumio[3153]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseState Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseTrackInfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseTrackInfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseTrackInfo Apr 11 09:34:07 volumio volumio[3153]: verbose: ControllerMpd::parseTrackInfo Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::servicePushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2115,"duration":300,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Blue And Sentimental","artist":"Teddy Edwards","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf","trackType":"dsf"} Apr 11 09:34:07 volumio volumio[3153]: verbose: CURRENT POSITION 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState stateService play Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState currentStatus play Apr 11 09:34:07 volumio volumio[3153]: info: Received an update from plugin. extracting info from payload Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::servicePushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2115,"duration":300,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Blue And Sentimental","artist":"Teddy Edwards","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf","trackType":"dsf"} Apr 11 09:34:07 volumio volumio[3153]: verbose: CURRENT POSITION 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState stateService play Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState currentStatus play Apr 11 09:34:07 volumio volumio[3153]: info: Received an update from plugin. extracting info from payload Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::servicePushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2115,"duration":300,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Blue And Sentimental","artist":"Teddy Edwards","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf","trackType":"dsf"} Apr 11 09:34:07 volumio volumio[3153]: verbose: CURRENT POSITION 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState stateService play Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState currentStatus play Apr 11 09:34:07 volumio volumio[3153]: info: Received an update from plugin. extracting info from payload Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:07 volumio volumio[3153]: info: ControllerMpd::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::servicePushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2492,"duration":300,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Blue And Sentimental","artist":"Teddy Edwards","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf","trackType":"dsf"} Apr 11 09:34:07 volumio volumio[3153]: verbose: CURRENT POSITION 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState stateService play Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::syncState currentStatus play Apr 11 09:34:07 volumio volumio[3153]: info: Received an update from plugin. extracting info from payload Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:07 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:07 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:07 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.028+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2115 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.028+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.028+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2115 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.029+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.029+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2115 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.029+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.030+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2115 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.030+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.034+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2115 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.034+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.036+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2115 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.037+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.039+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2492 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.041+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.041+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2492 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.042+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio[3153]: info: ------------------------------ 574ms Apr 11 09:34:08 volumio volumio[3153]: info: ------------------------------ 571ms Apr 11 09:34:08 volumio volumio[3153]: info: ------------------------------ 570ms Apr 11 09:34:08 volumio volumio[3153]: info: ------------------------------ 161ms Apr 11 09:34:08 volumio volumio[3153]: info: sendMpdCommand playlistinfo took 134 milliseconds Apr 11 09:34:08 volumio volumio[3153]: verbose: ControllerMpd::parseTrackInfo Apr 11 09:34:08 volumio volumio[3153]: info: ControllerMpd::pushState Apr 11 09:34:08 volumio volumio[3153]: info: CoreCommandRouter::servicePushState Apr 11 09:34:08 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:08 volumio volumio[3153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2492,"duration":300,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Blue And Sentimental","artist":"Teddy Edwards","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf","trackType":"dsf"} Apr 11 09:34:08 volumio volumio[3153]: verbose: CURRENT POSITION 1 Apr 11 09:34:08 volumio volumio[3153]: info: CoreStateMachine::syncState stateService play Apr 11 09:34:08 volumio volumio[3153]: info: CoreStateMachine::syncState currentStatus play Apr 11 09:34:08 volumio volumio[3153]: info: Received an update from plugin. extracting info from payload Apr 11 09:34:08 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:08 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:08 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:08 volumio volumio[3153]: info: CoreStateMachine::pushState Apr 11 09:34:08 volumio volumio[3153]: info: CorePlayQueue::getTrack 1 Apr 11 09:34:08 volumio volumio[3153]: info: CoreCommandRouter::volumioPushState Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.103+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2492 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.103+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.104+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" state=STATUS_PLAYING positionMs=2492 volume=100 Apr 11 09:34:08 volumio volumio5-onboarding[2058]: time=2026-04-11T09:34:08.104+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:50820 @ 0xc0000965a0" id="music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/01 - Teddy Edwards - Blue And Sentimental.dsf" title="Blue And Sentimental" Apr 11 09:34:08 volumio volumio[3153]: info: ------------------------------ 199ms Apr 11 09:34:08 volumio volumio[3153]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 09:34:08 volumio volumio[3153]: Error: connect ECONNREFUSED 4.78.139.50:443 Apr 11 09:34:08 volumio volumio[3153]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Apr 11 09:34:08 volumio volumio[3153]: errno: -111, Apr 11 09:34:08 volumio volumio[3153]: code: 'ECONNREFUSED', Apr 11 09:34:08 volumio volumio[3153]: syscall: 'connect', Apr 11 09:34:08 volumio volumio[3153]: address: '4.78.139.50', Apr 11 09:34:08 volumio volumio[3153]: port: 443 Apr 11 09:34:08 volumio volumio[3153]: } Apr 11 09:34:08 volumio volumio[3153]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 09:34:08 volumio sudo[4489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-11 09:33' Apr 11 09:34:08 volumio sudo[4489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"