Apr 11 22:31:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:07 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:11 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:15 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:19 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
Apr 11 22:31:21 volumio volumio[1083]: info: Share TrueNAS successfully unmounted
Apr 11 22:31:21 volumio sudo[13148]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=adrian,password=bgt5^YHNtn,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.78//dane /mnt/NAS/TrueNAS
Apr 11 22:31:21 volumio sudo[13148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 22:31:21 volumio kernel: Malformed UNC in devname
Apr 11 22:31:21 volumio kernel: CIFS: VFS: Malformed UNC in devname
Apr 11 22:31:21 volumio sudo[13148]: pam_unix(sudo:session): session closed for user root
Apr 11 22:31:21 volumio volumio[1083]: info: An error occurred mounting the new share. Rolling back configuration
Apr 11 22:31:22 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 11 22:31:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:27 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:31 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:31 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 11 22:31:31 volumio volumio[1083]: info: Received Get System Info
Apr 11 22:31:31 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 22:31:31 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 22:31:31 volumio volumio[1083]: info: Discovery: Getting this device information
Apr 11 22:31:31 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState
Apr 11 22:31:31 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 22:31:35 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
Apr 11 22:31:39 volumio volumio[1083]: info: Share TrueNAS successfully unmounted
Apr 11 22:31:39 volumio sudo[13208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=adrian,password=bgt5^YHNtn,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.100.78/DANE /mnt/NAS/TrueNAS
Apr 11 22:31:39 volumio sudo[13208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 22:31:39 volumio kernel: CIFS: Attempting to mount //192.168.100.78/DANE
Apr 11 22:31:39 volumio sudo[13208]: pam_unix(sudo:session): session closed for user root
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 22:31:39 volumio volumio[1083]: info:
Apr 11 22:31:39 volumio volumio[1083]: ---------------------------- MPD announces state update: update
Apr 11 22:31:39 volumio volumio[1083]: info: ControllerMpd::getState
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 22:31:39 volumio volumio[1083]: info:
Apr 11 22:31:39 volumio volumio[1083]: ---------------------------- MPD announces state update: update
Apr 11 22:31:39 volumio volumio[1083]: info: ControllerMpd::getState
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 22:31:39 volumio volumio[1083]: info: sendMpdCommand status took 22 milliseconds
Apr 11 22:31:39 volumio volumio[1083]: info: sendMpdCommand status took 19 milliseconds
Apr 11 22:31:39 volumio volumio[1083]: info: sendMpdCommand status took 20 milliseconds
Apr 11 22:31:39 volumio volumio[1083]: info: sendMpdCommand status took 18 milliseconds
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::parseState
Apr 11 22:31:39 volumio volumio[1083]: info: Command Router : Notfying DB Updatetrue
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::parseState
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::parseState
Apr 11 22:31:39 volumio volumio[1083]: info: Command Router : Notfying DB Updatetrue
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::Close All Modals sent
Apr 11 22:31:39 volumio volumio[1083]: verbose: ControllerMpd::parseState
Apr 11 22:31:39 volumio volumio[1083]: info: ControllerMpd::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CorePlayQueue::getTrack 0
Apr 11 22:31:39 volumio volumio[1083]: 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}
Apr 11 22:31:39 volumio volumio[1083]: verbose: CURRENT POSITION 0
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::stPlaybackTimer
Apr 11 22:31:39 volumio volumio[1083]: info: ControllerMpd::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CorePlayQueue::getTrack 0
Apr 11 22:31:39 volumio volumio[1083]: 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}
Apr 11 22:31:39 volumio volumio[1083]: verbose: CURRENT POSITION 0
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: No code
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.336+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_STOPPED positionMs=0 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.336+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=68000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.336+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.336+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=68000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.336+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.336+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.337+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=68000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.338+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.338+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=68000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.339+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio[1083]: info: ------------------------------ 95ms
Apr 11 22:31:39 volumio volumio[1083]: info: ------------------------------ 94ms
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is not playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Clipped samples monitor stopped
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: warn: FusionDsp - Monitor WebSocket not open, skipping commands
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: [1775939499362] Database update started
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Clipping Monitor reconnecting in 2000ms
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Clipping Monitor started
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Clipping Monitor started
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Clipping Monitor started
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.450+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.451+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.455+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.451+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.455+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.451+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.455+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.451+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.455+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.451+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.456+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.451+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.456+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.452+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.452+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.452+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=69000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.460+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.460+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.461+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.464+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.597+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.597+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.597+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.598+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.598+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.598+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.598+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.598+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.598+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.599+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.600+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.600+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.639+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.640+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.640+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.640+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.641+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.641+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.642+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.642+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.643+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.643+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.643+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.644+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.644+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.648+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.649+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.652+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.652+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.654+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.655+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.655+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 11 22:31:39 volumio volumio[1083]: info: Received Get System Info
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 22:31:39 volumio volumio[1083]: info: Discovery: Getting this device information
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 22:31:39 volumio nmbd[1111]: [2026/04/11 22:31:39.833944, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 22:31:39 volumio nmbd[1111]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.100.150 for name WORKGROUP<1d>.
Apr 11 22:31:39 volumio nmbd[1111]: This response was from IP 192.168.100.78, reporting an IP address of 192.168.100.78.
Apr 11 22:31:39 volumio nmbd[1111]: [2026/04/11 22:31:39.834319, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 22:31:39 volumio nmbd[1111]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.100.150 for name WORKGROUP<1d>.
Apr 11 22:31:39 volumio nmbd[1111]: This response was from IP 192.168.100.78, reporting an IP address of 192.168.100.78.
Apr 11 22:31:39 volumio nmbd[1111]: [2026/04/11 22:31:39.834513, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 22:31:39 volumio nmbd[1111]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.100.150 for name WORKGROUP<1d>.
Apr 11 22:31:39 volumio nmbd[1111]: This response was from IP 192.168.100.78, reporting an IP address of 192.168.100.78.
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:39 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.945+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.947+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.946+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.946+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.947+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.946+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.947+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.947+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.946+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.946+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.946+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.947+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.947+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.946+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.947+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97323000 volume=33
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.948+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.948+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.952+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.952+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:39.953+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:39 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.220+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.220+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.221+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.222+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.222+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.222+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.222+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.223+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.223+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.223+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.223+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.223+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.224+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.224+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.224+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.224+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.224+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.225+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.225+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.225+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.261+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.262+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.262+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.262+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.263+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.263+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.263+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.263+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.264+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.264+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.264+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.264+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.265+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.265+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.265+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.266+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.266+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97322000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.267+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.267+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.268+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.461+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.462+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.462+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.462+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.462+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.462+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.462+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.462+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.463+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.464+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.464+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.464+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-97321000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.464+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.543+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.543+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.543+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.543+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.544+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.545+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.545+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.545+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.545+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.545+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.546+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.546+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.546+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.546+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.548+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.548+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.549+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.550+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.549+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.550+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:40 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.605+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.607+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.607+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.607+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.607+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.608+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.608+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.608+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.608+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.608+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.608+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.609+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.610+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.610+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.611+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.611+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.611+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.611+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.611+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:40 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:40.611+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:40 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.079+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.079+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.080+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.080+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.080+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.080+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.081+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.081+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.081+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.083+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.083+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.084+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.084+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.085+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.085+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.086+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.087+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.086+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.088+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.088+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.357+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.359+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.358+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.364+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.358+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.364+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.358+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.364+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.358+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.365+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.358+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.365+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.359+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.359+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.369+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.359+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.369+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.359+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.370+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.373+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::servicePushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:31:41 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.384+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.384+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.384+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.385+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.386+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.390+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.391+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.391+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.391+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.391+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.392+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.392+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.392+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.392+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.396+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.398+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.398+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.398+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.399+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_PLAYING positionMs=-48696000 volume=33
Apr 11 22:31:41 volumio volumio5-onboarding[1749]: time=2026-04-11T22:31:41.401+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id= title=
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:41 volumio volumio[1083]: info: FusionDsp - Volumio is playing
Apr 11 22:31:43 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:47 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 22:31:50 volumio volumio[1083]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 11 22:31:50 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 22:31:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 22:31:53 volumio volumio[1083]: info: CURURI: artists://
Apr 11 22:31:53 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:11 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 22:32:11 volumio volumio[1083]: info: CURURI: music-library
Apr 11 22:32:11 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:13 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 22:32:13 volumio volumio[1083]: info: CURURI: music-library/NAS
Apr 11 22:32:13 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:14 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 22:32:14 volumio volumio[1083]: info: CURURI: music-library/NAS/TrueNAS
Apr 11 22:32:14 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 22:32:17 volumio volumio[1083]: info: CURURI: music-library/NAS/TrueNAS/Muzyka
Apr 11 22:32:17 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:20 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 22:32:20 volumio volumio[1083]: info: CURURI: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^
Apr 11 22:32:21 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/09 Napad na bankiet.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/02 Lepiej jak jest lepiej.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/14 Chcemy być wyżej.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/12 MC Hasselblad.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/10 Z Tobą.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/07 Za ręce.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/11 Skażony.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/05 Sprytny Eskimos.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/08 Nie da na da.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/03 Pluszowy.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/01 Hybryda.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/13 Koniec gatunku.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/04 Pomyłka.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/06 I tak i nie.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/09 Napad na bankiet.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82%2C%20PRO8L3M%2C%20Steez83%2C%20Taco%20Hemingway/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F09%20Napad%20na%20bankiet.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/09 Napad na bankiet.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/02 Lepiej jak jest lepiej.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82%2C%20Mateusz%20Krautwurst/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F02%20Lepiej%20jak%20jest%20lepiej.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/02 Lepiej jak jest lepiej.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/14 Chcemy być wyżej.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F14%20Chcemy%20by%C4%87%20wy%C5%BCej.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/14 Chcemy być wyżej.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/12 MC Hasselblad.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F12%20MC%20Hasselblad.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/12 MC Hasselblad.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/10 Z Tobą.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F10%20Z%20Tob%C4%85.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/10 Z Tobą.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/07 Za ręce.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F07%20Za%20r%C4%99ce.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/07 Za ręce.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/11 Skażony.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F11%20Ska%C5%BCony.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/11 Skażony.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/05 Sprytny Eskimos.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82%2C%20Igo/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F05%20Sprytny%20Eskimos.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/05 Sprytny Eskimos.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/08 Nie da na da.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82%2C%20Marcin%20Pyszora/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F08%20Nie%20da%20na%20da.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/08 Nie da na da.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/03 Pluszowy.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F03%20Pluszowy.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/03 Pluszowy.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/01 Hybryda.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F01%20Hybryda.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/01 Hybryda.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/13 Koniec gatunku.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82%2C%20Lena%20Osi%C5%84ska/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F13%20Koniec%20gatunku.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/13 Koniec gatunku.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/04 Pomyłka.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82%2C%20Andrzej%20Zaucha/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F04%20Pomy%C5%82ka.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/04 Pomyłka.flac
Apr 11 22:32:21 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/06 I tak i nie.flac in service mpd
Apr 11 22:32:21 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Sok%C3%B3%C5%82%2C%20Hewra/Wojtek%20Sok%C3%B3%C5%82/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FSok%C3%B3%C5%82%20-%20Wojtek%20Sok%C3%B3%C5%82%20(2019%3B%202019-02-15)%20%5ERap%2CHip%20Hop%5E%20%5E973kbps%5E%2F06%20I%20tak%20i%20nie.flac&metadata=false
Apr 11 22:32:21 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/Sokół - Wojtek Sokół (2019; 2019-02-15) ^Rap,Hip Hop^ ^973kbps^/06 I tak i nie.flac
Apr 11 22:32:31 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 22:32:31 volumio volumio[1083]: info: CURURI: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]
Apr 11 22:32:31 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/12 - Daffodil Lament.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/05 - Empty.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/07 - The Icicle Melts.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/09 - Ridiculous Thoughts.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/02 - I Can't Be With You.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/10 - Dreaming My Dreams.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/04 - Zombie.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/08 - Disappointment.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/06 - Everything I Said.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/03 - Twenty-One.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/11 - Yeat's Grave.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/13 - No Need To Argue.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Preloading song: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/01 - Ode To My Family.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/12 - Daffodil Lament.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F12%20-%20Daffodil%20Lament.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/12 - Daffodil Lament.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/05 - Empty.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F05%20-%20Empty.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/05 - Empty.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/07 - The Icicle Melts.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F07%20-%20The%20Icicle%20Melts.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/07 - The Icicle Melts.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/09 - Ridiculous Thoughts.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F09%20-%20Ridiculous%20Thoughts.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/09 - Ridiculous Thoughts.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/02 - I Can't Be With You.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F02%20-%20I%20Can't%20Be%20With%20You.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/02 - I Can't Be With You.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/10 - Dreaming My Dreams.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F10%20-%20Dreaming%20My%20Dreams.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/10 - Dreaming My Dreams.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/04 - Zombie.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F04%20-%20Zombie.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/04 - Zombie.flac
Apr 11 22:32:31 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/08 - Disappointment.flac in service mpd
Apr 11 22:32:31 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F08%20-%20Disappointment.flac&metadata=false
Apr 11 22:32:31 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/08 - Disappointment.flac
Apr 11 22:32:32 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/06 - Everything I Said.flac in service mpd
Apr 11 22:32:32 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F06%20-%20Everything%20I%20Said.flac&metadata=false
Apr 11 22:32:32 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/06 - Everything I Said.flac
Apr 11 22:32:32 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/03 - Twenty-One.flac in service mpd
Apr 11 22:32:32 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F03%20-%20Twenty-One.flac&metadata=false
Apr 11 22:32:32 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/03 - Twenty-One.flac
Apr 11 22:32:32 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/11 - Yeat's Grave.flac in service mpd
Apr 11 22:32:32 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F11%20-%20Yeat's%20Grave.flac&metadata=false
Apr 11 22:32:32 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/11 - Yeat's Grave.flac
Apr 11 22:32:32 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/13 - No Need To Argue.flac in service mpd
Apr 11 22:32:32 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F13%20-%20No%20Need%20To%20Argue.flac&metadata=false
Apr 11 22:32:32 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/13 - No Need To Argue.flac
Apr 11 22:32:32 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/01 - Ode To My Family.flac in service mpd
Apr 11 22:32:32 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=The%20Cranberries/No%20Need%20To%20Argue/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2F01%20-%20Ode%20To%20My%20Family.flac&metadata=false
Apr 11 22:32:32 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/01 - Ode To My Family.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::ClearQueue
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::stop
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::serviceStop
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::serviceStop
Apr 11 22:32:38 volumio volumio[1083]: info: Airplay Stop
Apr 11 22:32:38 volumio volumio[1083]: info: Stopping Airplay Playback and sending pause command to client via USR2
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::clearPlayQueue
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::saveQueue
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::volumioPushQueue
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::addQueueItems
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::addQueueItems
Apr 11 22:32:38 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/12 - Daffodil Lament.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/12 - Daffodil Lament.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/05 - Empty.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/05 - Empty.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/07 - The Icicle Melts.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/07 - The Icicle Melts.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/09 - Ridiculous Thoughts.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/09 - Ridiculous Thoughts.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/02 - I Can't Be With You.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/02 - I Can't Be With You.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/10 - Dreaming My Dreams.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/10 - Dreaming My Dreams.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/04 - Zombie.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/04 - Zombie.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/08 - Disappointment.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/08 - Disappointment.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/06 - Everything I Said.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/06 - Everything I Said.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/03 - Twenty-One.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/03 - Twenty-One.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/11 - Yeat's Grave.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/11 - Yeat's Grave.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/13 - No Need To Argue.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/13 - No Need To Argue.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/01 - Ode To My Family.flac
Apr 11 22:32:38 volumio volumio[1083]: info: Using cached record of: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/01 - Ode To My Family.flac
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::volumioPushQueue
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::saveQueue
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::updateTrackBlock
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::getTrackBlock
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::volumioPlay
Apr 11 22:32:38 volumio volumio[1083]: verbose: UNSET VOLATILE: Service: airplay_emulation
Apr 11 22:32:38 volumio volumio[1083]: info: Stopping Airplay Playback and sending pause command to client via USR2
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::play index 12
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::addQueueItems
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::addQueueItems
Apr 11 22:32:38 volumio volumio[1083]: info: Preload queue cleared
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/No Need To Argue.cue
Apr 11 22:32:38 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/No Need To Argue.cue in service mpd
Apr 11 22:32:38 volumio sudo[13420]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 11018
Apr 11 22:32:38 volumio sudo[13420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 22:32:38 volumio sudo[13419]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 11018
Apr 11 22:32:38 volumio sudo[13419]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/No Need To Argue.cue
Apr 11 22:32:38 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/No Need To Argue.cue in service mpd
Apr 11 22:32:38 volumio shairport-sync[13009]: {"time":1775939440129,"response":"startAirplayPlayback Success"}
Apr 11 22:32:38 volumio sudo[13420]: pam_unix(sudo:session): session closed for user root
Apr 11 22:32:38 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=12/USR2
Apr 11 22:32:38 volumio systemd[1]: shairport-sync.service: Failed with result 'signal'.
Apr 11 22:32:38 volumio sudo[13419]: pam_unix(sudo:session): session closed for user root
Apr 11 22:32:38 volumio systemd[1]: shairport-sync.service: Consumed 1min 41.282s CPU time.
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP
Apr 11 22:32:38 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP in service mpd
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/No Need To Argue.cue
Apr 11 22:32:38 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/No Need To Argue.cue in service mpd
Apr 11 22:32:38 volumio volumio[1083]: info: Adding Item to queue: music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/scans
Apr 11 22:32:38 volumio volumio[1083]: info: Exploding uri music-library/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/scans in service mpd
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::stop
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::stPlaybackTimer
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::updateTrackBlock
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::getTrackBlock
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::pushState
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::getTrack 0
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState
Apr 11 22:32:38 volumio volumio[1083]: info: CoreStateMachine::serviceStop
Apr 11 22:32:38 volumio volumio[1083]: info: CorePlayQueue::getTrack 0
Apr 11 22:32:38 volumio volumio[1083]: info: CoreCommandRouter::serviceStop
Apr 11 22:32:38 volumio volumio[1083]: info: ControllerMpd::stop
Apr 11 22:32:38 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 22:32:38 volumio volumio5-onboarding[1749]: time=2026-04-11T22:32:38.945+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" state=STATUS_STOPPED positionMs=0 volume=33
Apr 11 22:32:38 volumio volumio5-onboarding[1749]: time=2026-04-11T22:32:38.946+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.100.148:64048 @ 0xc0000c0cf0" id="mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/12 - Daffodil Lament.flac" title="Daffodil Lament"
Apr 11 22:32:38 volumio volumio[1083]: info: FusionDsp - Volumio is not playing
Apr 11 22:32:38 volumio volumio[1083]: info: FusionDsp - Clipped samples monitor stopped
Apr 11 22:32:38 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Cranberries%2C%20The/No%20Need%20To%20Argue%20%5BThe%20Live%20'E.P.'%5D/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2FThe%20Live%20EP%2F01%20-%20Zombie.flac&metadata=false
Apr 11 22:32:38 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP/01 - Zombie.flac
Apr 11 22:32:38 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Cranberries%2C%20The/No%20Need%20To%20Argue%20%5BThe%20Live%20'E.P.'%5D/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2FThe%20Live%20EP%2F02%20-%20Dreams.flac&metadata=false
Apr 11 22:32:38 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP/02 - Dreams.flac
Apr 11 22:32:38 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Cranberries%2C%20The/No%20Need%20To%20Argue%20%5BThe%20Live%20'E.P.'%5D/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2FThe%20Live%20EP%2F03%20-%20Linger.flac&metadata=false
Apr 11 22:32:38 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP/03 - Linger.flac
Apr 11 22:32:38 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Cranberries%2C%20The/No%20Need%20To%20Argue%20%5BThe%20Live%20'E.P.'%5D/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2FThe%20Live%20EP%2F04%20-%20Ridiculous%20Thoughts.flac&metadata=false
Apr 11 22:32:38 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP/04 - Ridiculous Thoughts.flac
Apr 11 22:32:38 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Cranberries%2C%20The/No%20Need%20To%20Argue%20-%20The%20Live%20EP/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2FThe%20Live%20EP%2FNo%20Need%20To%20Argue%20-%20The%20Live%20EP.cue&metadata=false
Apr 11 22:32:38 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP/No Need To Argue - The Live EP.cue
Apr 11 22:32:38 volumio volumio[1083]: info: ALBUMART /albumart?cacheid=716&web=Cranberries%2C%20The/No%20Need%20To%20Argue%20-%20The%20Live%20EP/extralarge&path=%2Fmnt%2FNAS%2FTrueNAS%2FMuzyka%2FThe%20Cranberries%20-%20No%20Need%20To%20Argue%20%5BFLAC-2cd-1994%5D%2FThe%20Live%20EP%2FNo%20Need%20To%20Argue%20-%20The%20Live%20EP.cue&metadata=false
Apr 11 22:32:38 volumio volumio[1083]: info: URI /mnt/NAS/TrueNAS/Muzyka/The Cranberries - No Need To Argue [FLAC-2cd-1994]/The Live EP/No Need To Argue - The Live EP.cue
Apr 11 22:32:39 volumio volumio[1083]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 22:32:39 volumio volumio[1083]: Error: Unable to resolve or reject the same promise twice
Apr 11 22:32:39 volumio volumio[1083]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Apr 11 22:32:39 volumio volumio[1083]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21
Apr 11 22:32:39 volumio volumio[1083]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Apr 11 22:32:39 volumio volumio[1083]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Apr 11 22:32:39 volumio volumio[1083]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Apr 11 22:32:39 volumio volumio[1083]: at Socket.emit (node:events:514:28)
Apr 11 22:32:39 volumio volumio[1083]: at addChunk (node:internal/streams/readable:343:12)
Apr 11 22:32:39 volumio volumio[1083]: at readableAddChunk (node:internal/streams/readable:312:11)
Apr 11 22:32:39 volumio volumio[1083]: at Readable.push (node:internal/streams/readable:253:10)
Apr 11 22:32:39 volumio volumio[1083]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Apr 11 22:32:39 volumio volumio[1083]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 22:32:40 volumio sudo[13439]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-11 22:31'
Apr 11 22:32:40 volumio sudo[13439]: 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"