Aug 28 14:10:06 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:10:06 volumio volumio[1249]: info: [jellyfin-browse] browseUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47 Aug 28 14:10:06 volumio volumio[1249]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"fe466fa9bfa5c501c3b7edaf33bd5d47","startIndex":0,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"includeItemTypes":["Audio"]} Aug 28 14:10:07 volumio volumio[1249]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&recursive=true&sortOrder=Ascending&parentId=fe466fa9bfa5c501c3b7edaf33bd5d47&fields=MediaSources&includeItemTypes=Audio&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:10:07 volumio volumio[1249]: info: Preload queue cleared Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:10:07 volumio volumio[1249]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:10:07 volumio volumio[1249]: info: Preload queue cleared Aug 28 14:10:11 volumio volumio[1249]: info: Preload queue cleared Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::ClearQueue Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::stop Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::stPlaybackTimer Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::updateTrackBlock Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrackBlock Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::pushState Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 5 Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::serviceStop Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 5 Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::serviceStop Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 28 14:10:11 volumio volumio[1249]: info: ControllerMpd::stop Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand stop Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::clearPlayQueue Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::saveQueue Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::addQueueItems Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::addQueueItems Aug 28 14:10:11 volumio volumio[1249]: info: Preload queue cleared Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.732+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_STOPPED positionMs=0 volume=100 Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.732+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=fe3404a1f183f3f5768035bc444a4647" title="Sempre Sempre" Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Volumio is not playing Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Clipped samples monitor stopped Aug 28 14:10:11 volumio volumio[1249]: info: ControllerMpd::getState Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:10:11 volumio volumio[1249]: info: Aug 28 14:10:11 volumio volumio[1249]: ---------------------------- MPD announces state update: player Aug 28 14:10:11 volumio volumio[1249]: info: sendMpdCommand stop took 16 milliseconds Aug 28 14:10:11 volumio volumio[1249]: info: ControllerMpd::getState Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:10:11 volumio volumio[1249]: info: sendMpdCommand status took 2 milliseconds Aug 28 14:10:11 volumio volumio[1249]: info: sendMpdCommand status took 1 milliseconds Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::parseState Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::parseState Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 14:10:11 volumio volumio[1249]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 28 14:10:11 volumio volumio[1249]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:10:11 volumio volumio[1249]: verbose: ControllerMpd::parseTrackInfo Aug 28 14:10:11 volumio volumio[1249]: info: ControllerMpd::pushState Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::servicePushState Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::pushState Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 5 Aug 28 14:10:11 volumio volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sempre Sempre","artist":"Andrea Bocelli","album":"Andrea Bocelli","uri":"http://192.168.178.20:8096/Audio/fe3404a1f183f3f5768035bc444a4647/stream.flac?static=true&mediaSourceId=fe3404a1f183f3f5768035bc444a4647&tag=6a73338673ed05f097b7cd1dcfb9913a&t.flac","trackType":"flac"} Aug 28 14:10:11 volumio volumio[1249]: verbose: CURRENT POSITION 5 Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::syncState stateService stop Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::pushState Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:11 volumio volumio[1249]: info: No code Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::pushState Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.757+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=0 volume=100 Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.757+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=fe3404a1f183f3f5768035bc444a4647" title="Sempre Sempre" Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.758+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=0 volume=100 Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.758+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=fe3404a1f183f3f5768035bc444a4647" title="Sempre Sempre" Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.759+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" state=STATUS_PLAYING positionMs=0 volume=100 Aug 28 14:10:11 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:11.760+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" id="jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=fe3404a1f183f3f5768035bc444a4647" title="Sempre Sempre" Aug 28 14:10:11 volumio volumio[1249]: info: ------------------------------ 19ms Aug 28 14:10:11 volumio volumio[1249]: info: Pushing Favourites {"favourite":false} Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Volumio is playing Aug 28 14:10:11 volumio volumio[1249]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Volumio is playing Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Volumio is playing Aug 28 14:10:11 volumio volumio[1249]: info: Pushing Favourites {"service":"mpd","uri":"jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=fe3404a1f183f3f5768035bc444a4647","favourite":false} Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Clipping Monitor started Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Clipping Monitor started Aug 28 14:10:11 volumio volumio[1249]: info: FusionDsp - Clipping Monitor started Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-play]: Reported 'stop' for song: Sempre Sempre (at 31395 ms) Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::saveQueue Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::updateTrackBlock Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrackBlock Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPlay Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::play index 2 Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::addQueueItems Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::addQueueItems Aug 28 14:10:11 volumio volumio[1249]: info: Preload queue cleared Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:10:11 volumio volumio[1249]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:10:11 volumio volumio[1249]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e in service jellyfin Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::stop Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::play index undefined Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 2 Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::startPlaybackTimer Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 2 Aug 28 14:10:11 volumio volumio[1249]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:10:11 volumio volumio[1249]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::saveQueue Aug 28 14:10:11 volumio volumio[1249]: info: CoreStateMachine::updateTrackBlock Aug 28 14:10:11 volumio volumio[1249]: info: CorePlayQueue::getTrackBlock Aug 28 14:10:11 volumio volumio[1249]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:10:11 volumio volumio[1249]: Error: No media streams found for song 03-Puerto Rico Aug 28 14:10:11 volumio volumio[1249]: at PlayController._PlayController_getStreamUrl (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:241:15) Aug 28 14:10:11 volumio volumio[1249]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:78:234) Aug 28 14:10:11 volumio volumio[1249]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 14:10:11 volumio volumio[1249]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:10:12 volumio sudo[12571]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 14:09' Aug 28 14:10:12 volumio sudo[12571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:12 volumio sudo[12571]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:12 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:12.728+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Aug 28 14:10:12 volumio volumio-remote-updater[730]: [2026-08-28 14:10:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 28 14:10:12 volumio volumio-remote-updater[730]: [2026-08-28 14:10:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 28 14:10:12 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 28 14:10:12 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:12.731+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:58724->127.0.0.1:3000: read: connection reset by peer" Aug 28 14:10:12 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 28 14:10:12 volumio systemd[1]: volumio.service: Consumed 10min 42.715s CPU time. Aug 28 14:10:12 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Aug 28 14:10:12 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Aug 28 14:10:12 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Aug 28 14:10:12 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Aug 28 14:10:12 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Aug 28 14:10:12 volumio systemd[1]: volumio.service: Consumed 10min 42.715s CPU time. Aug 28 14:10:13 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Aug 28 14:10:13 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Aug 28 14:10:13 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:13.733+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 28 14:10:14 volumio volumio[12611]: info: ------------------------------------------- Aug 28 14:10:14 volumio volumio[12611]: info: ----- Volumio3 ---- Aug 28 14:10:14 volumio volumio[12611]: info: ------------------------------------------- Aug 28 14:10:14 volumio volumio[12611]: info: ----- System startup ---- Aug 28 14:10:14 volumio volumio[12611]: info: ------------------------------------------- Aug 28 14:10:14 volumio volumio[12611]: info: MYVOLUMIO Environment detected Aug 28 14:10:14 volumio volumio[12611]: info: Plugin folders cleanup Aug 28 14:10:14 volumio volumio[12611]: info: Scanning into folder /volumio/app/plugins/ Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category audio_interface Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category miscellanea Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category music_service Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category plugins.json Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category system_controller Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category user_interface Aug 28 14:10:14 volumio volumio[12611]: info: Scanning into folder /data/plugins/ Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category audio_interface Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category music_service Aug 28 14:10:14 volumio volumio[12611]: info: Scanning category user_interface Aug 28 14:10:14 volumio volumio[12611]: info: Plugin folders cleanup completed Aug 28 14:10:14 volumio volumio[12611]: info: ------------------------------------------- Aug 28 14:10:14 volumio volumio[12611]: info: ----- Core plugins startup ---- Aug 28 14:10:14 volumio volumio[12611]: info: ------------------------------------------- Aug 28 14:10:14 volumio volumio[12611]: info: Loading plugins from folder /volumio/app/plugins/ Aug 28 14:10:14 volumio volumio[12611]: info: Adding plugin upnp to MyMusic Plugins Aug 28 14:10:14 volumio volumio[12611]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 28 14:10:14 volumio volumio[12611]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 28 14:10:14 volumio volumio[12611]: info: Loading plugins from folder /data/plugins/ Aug 28 14:10:14 volumio volumio[12611]: info: Loading plugin "system"... Aug 28 14:10:14 volumio volumio[12611]: info: Loading plugin "appearance"... Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "network"... Aug 28 14:10:15 volumio volumio[12611]: info: Refreshing Cached IP Addresses Aug 28 14:10:15 volumio sudo[12639]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 28 14:10:15 volumio sudo[12639]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "services"... Aug 28 14:10:15 volumio sudo[12641]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 28 14:10:15 volumio sudo[12639]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:15 volumio sudo[12641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "volumio5onboarding"... Aug 28 14:10:15 volumio sudo[12641]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:15 volumio sudo[12649]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 28 14:10:15 volumio sudo[12649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "alsa_controller"... Aug 28 14:10:15 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "wizard"... Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "networkfs"... Aug 28 14:10:15 volumio volumio[12611]: info: Cannot mount NAS WernerClasicMusik at system boot, trial number 1 ,retrying in 5 seconds Aug 28 14:10:15 volumio volumio[12611]: info: Cannot mount NAS WernerFlacMusik at system boot, trial number 1 ,retrying in 5 seconds Aug 28 14:10:15 volumio volumio[12611]: info: Starting Udev Watcher for removable devices Aug 28 14:10:15 volumio volumio[12611]: info: Ignoring mount for partition: boot Aug 28 14:10:15 volumio volumio[12611]: info: Ignoring mount for partition: volumio Aug 28 14:10:15 volumio volumio[12611]: info: Ignoring mount for partition: volumio_data Aug 28 14:10:15 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "volumio_command_line_client"... Aug 28 14:10:15 volumio volumio[12611]: info: Plugin upnp is not enabled Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "my_music"... Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "mpd"... Aug 28 14:10:15 volumio volumio[12611]: info: Plugin upnp_browser is not enabled Aug 28 14:10:15 volumio volumio[12611]: info: Loading plugin "alarm-clock"... Aug 28 14:10:16 volumio volumio[12611]: info: Plugin airplay_emulation is not enabled Aug 28 14:10:16 volumio volumio[12611]: info: Loading plugin "last_100"... Aug 28 14:10:16 volumio volumio[12611]: info: Loading plugin "webradio"... Aug 28 14:10:16 volumio volumio[12611]: info: Loading plugin "i2s_dacs"... Aug 28 14:10:16 volumio volumio[12611]: info: Loading plugin "volumiodiscovery"... Aug 28 14:10:16 volumio volumio[12611]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:16 volumio node[12611]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:16 volumio volumio[12611]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:16 volumio node[12611]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:16 volumio volumio[12611]: *** WARNING *** For more information see Aug 28 14:10:16 volumio node[12611]: *** WARNING *** For more information see Aug 28 14:10:16 volumio volumio[12611]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:16 volumio node[12611]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:16 volumio volumio[12611]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:16 volumio node[12611]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:16 volumio volumio[12611]: *** WARNING *** For more information see Aug 28 14:10:16 volumio node[12611]: *** WARNING *** For more information see Aug 28 14:10:16 volumio volumio[12611]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 28 14:10:16 volumio volumio[12611]: info: Discovery: Started advertising with name: Volumio Aug 28 14:10:16 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 28 14:10:16 volumio volumio[12611]: info: Loading plugin "jellyfin"... Aug 28 14:10:17 volumio volumio[12611]: info: Loading plugin "now_playing"... Aug 28 14:10:17 volumio volumio-remote-updater[730]: [2026-08-28 14:10:17] [connect] Successful connection Aug 28 14:10:17 volumio volumio[12611]: info: Loading plugin "outputs"... Aug 28 14:10:17 volumio volumio[12611]: info: Loading plugin "albumart"... Aug 28 14:10:17 volumio volumio[12611]: info: Plugin example_plugin is not enabled Aug 28 14:10:17 volumio volumio[12611]: info: Loading plugin "inputs"... Aug 28 14:10:17 volumio volumio[12611]: info: Loading plugin "updater_comm"... Aug 28 14:10:18 volumio volumio[12611]: info: Plugin mpdemulation is not enabled Aug 28 14:10:18 volumio volumio[12611]: info: Loading plugin "rest_api"... Aug 28 14:10:18 volumio volumio[12611]: info: Loading plugin "websocket"... Aug 28 14:10:18 volumio volumio[12611]: info: Starting Socket.io Server version 1.7.4 Aug 28 14:10:18 volumio volumio[12611]: info: Loading plugin "fusiondsp"... Aug 28 14:10:18 volumio volumio[12674]: Forking 3 albumart workers Aug 28 14:10:18 volumio volumio[12611]: info: Applying required configuration parameters for plugin fusiondsp Aug 28 14:10:18 volumio volumio[12611]: info: Loading plugin "Systeminfo"... Aug 28 14:10:18 volumio volumio[12611]: info: Loading i18n strings for locale de Aug 28 14:10:18 volumio volumio[12611]: Updating browse sources language Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::initPlayerControls Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 14:10:18 volumio volumio[12611]: Express server listening on port 3000 Aug 28 14:10:18 volumio volumio[12611]: [Metrics] WebUI: 4s 919.31ms Aug 28 14:10:18 volumio volumio[12611]: info: CoreStateMachine::resetVolumioState Aug 28 14:10:18 volumio volumio[12611]: info: CoreStateMachine::getcurrentVolume Aug 28 14:10:18 volumio volumio[12611]: info: CoreCommandRouter::volumioRetrievevolume Aug 28 14:10:18 volumio sudo[12649]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:18 volumio volumio[12611]: info: Volumio Network Manager: Network status updated: 2 Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 28 14:10:19 volumio volumio[12611]: info: VolumeController:: Volume=100 Mute =false Aug 28 14:10:19 volumio volumio[12611]: info: CoreStateMachine::pushState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:19 volumio volumio[12611]: info: CoreStateMachine::updateTrackBlock Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrackBlock Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioRetrievevolume Aug 28 14:10:19 volumio volumio[12686]: Starting albumart workers Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:19 volumio volumio[12611]: info: Executing start script for DAC IQaudIO DAC Plus Aug 28 14:10:19 volumio volumio[12611]: info: Reloading queue from file Aug 28 14:10:19 volumio volumio[12685]: Starting albumart workers Aug 28 14:10:19 volumio volumio[12684]: Starting albumart workers Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to 192.168.178.28 from 192.168.178.22 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 1 Aug 28 14:10:19 volumio volumio[12611]: info: CoreStateMachine::setRepeat null single undefined Aug 28 14:10:19 volumio volumio[12611]: info: CoreStateMachine::pushState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:19 volumio volumio[12611]: info: CoreStateMachine::setRandom null Aug 28 14:10:19 volumio volumio[12611]: info: CoreStateMachine::pushState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:19 volumio volumio[12611]: info: Setting Device type: Raspberry PI Aug 28 14:10:19 volumio volumio-remote-updater[730]: [2026-08-28 14:10:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1787919017 101 Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 2 Aug 28 14:10:19 volumio volumio[12611]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 28 14:10:19 volumio volumio[12611]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Aug 28 14:10:19 volumio volumio[12611]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 28 14:10:19 volumio volumio[12611]: info: DAC script executed Aug 28 14:10:19 volumio volumio[12611]: info: Completed loading Core Plugins Aug 28 14:10:19 volumio volumio[12611]: info: Preparing to generate the ALSA configuration file Aug 28 14:10:19 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:19.334+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" available=true connected=true macAddress=e4:5f:01:1b:18:f9 ip4Address=192.168.178.28/24 ip6Address= ssid="FRITZ!Box 7530 DM" Aug 28 14:10:19 volumio volumio[12611]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 28 14:10:19 volumio volumio[12611]: info: Reading ALSA contributions from plugins. Aug 28 14:10:19 volumio volumio[12611]: info: VolumeController:: Volume=100 Mute =false Aug 28 14:10:19 volumio volumio[12611]: info: CoreStateMachine::pushState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:19 volumio volumio[12611]: info: Discovery: Getting this device information Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to 192.168.178.28 from 192.168.178.20 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.6 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 3 Aug 28 14:10:19 volumio volumio[12611]: info: Discovery: adding dab053da-dd83-465d-bebf-e3c7b3e8ba2e Aug 28 14:10:19 volumio volumio[12611]: info: Discovery: Found device Volumio Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: Discovery: this is already registered, dab053da-dd83-465d-bebf-e3c7b3e8ba2e Aug 28 14:10:19 volumio volumio[12611]: info: Discovery: Found device Volumio Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to 192.168.178.28 from 192.168.178.22 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 4 Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to 192.168.178.28:3000 from 192.168.178.22 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Aug 28 14:10:19 volumio volumio[12611]: info: Received Get System Info Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:19 volumio volumio[12611]: info: Discovery: Getting this device information Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 14:10:19 volumio volumio[12611]: info: Asound.conf file unchanged, so no further update is needed Aug 28 14:10:19 volumio volumio[12611]: info: Output device has changed, restarting MPD Aug 28 14:10:19 volumio volumio[12611]: info: ___________ START PLUGINS ___________ Aug 28 14:10:19 volumio sudo[12740]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 14:10:19 volumio sudo[12740]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:19 volumio volumio[12611]: info: ControllerMpd::onStart: Initializing MPD Aug 28 14:10:19 volumio sudo[12742]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 14:10:19 volumio volumio[12611]: info: Creating MPD Configuration file Aug 28 14:10:19 volumio sudo[12740]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:19 volumio sudo[12742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 14:10:19 volumio volumio[12611]: info: [1787919019684] CoreMusicLibrary::Adding element Last_100 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 14:10:19 volumio volumio[12611]: info: [1787919019690] CoreMusicLibrary::Adding element Webradio Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:19 volumio sudo[12745]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 28 14:10:19 volumio sudo[12745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:10:19 volumio volumio[12611]: info: Initializing BBC Radios Aug 28 14:10:19 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 28 14:10:19 volumio sudo[12748]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 14:10:19 volumio sudo[12748]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:19 volumio sudo[12748]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:19 volumio sudo[12756]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 14:10:19 volumio sudo[12756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:19 volumio sudo[12745]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:19 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 14:10:19 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 14:10:19 volumio systemd[1]: mpd.service: Consumed 51.068s CPU time. Aug 28 14:10:19 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 14:10:19 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 14:10:19 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:19 volumio volumio[12611]: info: Discovery: Getting this device information Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:19 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 14:10:19 volumio volumio[12611]: info: [1787919019810] CoreMusicLibrary::Adding element Jellyfin Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:19 volumio volumio[12611]: Cannot find translation for source Jellyfin Aug 28 14:10:19 volumio volumio[12611]: info: [jellyfin] Initialized plugin with device info: {"host":"http://192.168.178.28","id":"dab053da-dd83-465d-bebf-e3c7b3e8ba2e","name":"Volumio","serviceName":"Volumio","state":{"albumart":"http://192.168.178.28/albumart?sourceicon=music_service%2Fjellyfin%2Fdist%2Fassets%2Fimages%2Fsong.png","artist":"","mute":false,"status":"stop","track":"01-Don't Cry For Love","volume":100},"type":"device"} Aug 28 14:10:19 volumio volumio[12611]: info: [now-playing] ConfigUpdater: config is up to date. Aug 28 14:10:19 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 14:10:19 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 14:10:19 volumio volumio[12611]: info: FusionDsp - CamillaDSP binary found. Aug 28 14:10:19 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 14:10:19 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 14:10:19 volumio volumio[12611]: info: Loading i18n strings for locale de Aug 28 14:10:19 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 14:10:19 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 14:10:19 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 28 14:10:19 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:19 volumio volumio[12611]: info: FusionDsp - mixtype--------------------- Hardware Aug 28 14:10:19 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 14:10:19 volumio volumio[12611]: info: Volumio Calling Home Aug 28 14:10:19 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 14:10:19 volumio volumio[12611]: info: Preparing to generate the ALSA configuration file Aug 28 14:10:20 volumio sudo[12783]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 14:10:20 volumio sudo[12783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 14:10:20 volumio sudo[12783]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:20 volumio volumio[12611]: info: [now-playing] App is listening on port 4004. Aug 28 14:10:20 volumio volumio[12611]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:20 volumio volumio[12611]: info: Listing playlists Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::volumioGetQueue Aug 28 14:10:20 volumio volumio[12611]: info: CoreStateMachine::getQueue Aug 28 14:10:20 volumio volumio[12611]: info: CorePlayQueue::getQueue Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 14:10:20 volumio volumio[12611]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 28 14:10:20 volumio volumio[12611]: info: Reading ALSA contributions from plugins. Aug 28 14:10:20 volumio volumio[12611]: info: MPD Permissions set Aug 28 14:10:20 volumio volumio[12611]: info: MPD Permissions set Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:20 volumio volumio[12611]: info: Discovery: Getting this device information Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:20 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:20 volumio volumio[12611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 28 14:10:20 volumio volumio[12611]: info: Volumio called home Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 28 14:10:20 volumio volumio[12611]: verbose: New Socket.io Connection to 192.168.178.28:3000 from 192.168.178.22 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 14:10:20 volumio volumio[12611]: info: Asound.conf file unchanged, so no further update is needed Aug 28 14:10:20 volumio volumio[12611]: info: Output device has changed, restarting MPD Aug 28 14:10:20 volumio sudo[12801]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 14:10:20 volumio sudo[12801]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:20 volumio sudo[12801]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:20 volumio volumio[12611]: info: [jellyfin-poller] Polled http://192.168.178.20:8096: online Aug 28 14:10:20 volumio sudo[12803]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 14:10:20 volumio sudo[12803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:20 volumio volumio[12611]: info: MPD Permissions set Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 14:10:20 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 14:10:20 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 14:10:20 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 14:10:20 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:20 volumio volumio[12611]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:20 volumio volumio[12611]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:20 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 14:10:20 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 14:10:20 volumio volumio[12611]: info: Cannot mount NAS WernerClasicMusik at system boot, trial number 2 ,retrying in 5 seconds Aug 28 14:10:20 volumio volumio[12611]: info: Cannot mount NAS WernerFlacMusik at system boot, trial number 2 ,retrying in 5 seconds Aug 28 14:10:20 volumio sudo[12812]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 14:10:20 volumio sudo[12812]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 14:10:20 volumio sudo[12812]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:21 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:21.068+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 28 14:10:21 volumio mpd[12816]: 2026-08-28T14:10:21 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 28 14:10:21 volumio systemd[1]: Started mpd.service - Music Player Daemon. Aug 28 14:10:21 volumio sudo[12803]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:21 volumio sudo[12742]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:21 volumio sudo[12756]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:21 volumio volumio[12611]: info: Completed starting Core Plugins Aug 28 14:10:21 volumio volumio[12611]: info: ------------------------------------------- Aug 28 14:10:21 volumio volumio[12611]: info: ----- MyVolumio plugins startup ---- Aug 28 14:10:21 volumio volumio[12611]: info: ------------------------------------------- Aug 28 14:10:21 volumio volumio[12611]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 28 14:10:21 volumio volumio[12611]: error: MPD error: The expression evaluated to a falsy value: Aug 28 14:10:21 volumio volumio[12611]: assert.ok(self.idling) Aug 28 14:10:21 volumio volumio[12611]: error: The expression evaluated to a falsy value: Aug 28 14:10:21 volumio volumio[12611]: assert.ok(self.idling) Aug 28 14:10:21 volumio volumio[12611]: error: MPD error: The expression evaluated to a falsy value: Aug 28 14:10:21 volumio volumio[12611]: assert.ok(self.idling) Aug 28 14:10:21 volumio volumio[12611]: error: The expression evaluated to a falsy value: Aug 28 14:10:21 volumio volumio[12611]: assert.ok(self.idling) Aug 28 14:10:21 volumio volumio[12611]: error: updateQueue error: null Aug 28 14:10:21 volumio volumio[12611]: info: MPD running with PID12816 Aug 28 14:10:21 volumio volumio[12611]: ,establishing connection Aug 28 14:10:21 volumio volumio[12611]: error: updateQueue error: null Aug 28 14:10:25 volumio volumio[12611]: info: Cannot mount NAS WernerClasicMusik at system boot, trial number 3 ,retrying in 5 seconds Aug 28 14:10:25 volumio volumio[12611]: info: Cannot mount NAS WernerFlacMusik at system boot, trial number 3 ,retrying in 5 seconds Aug 28 14:10:26 volumio volumio[12611]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 28 14:10:28 volumio volumio[12611]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 28 14:10:28 volumio volumio[12611]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Aug 28 14:10:28 volumio volumio[12611]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 28 14:10:28 volumio volumio[12611]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 28 14:10:28 volumio volumio[12611]: info: camilladsp service started and running in background, instance 1 Aug 28 14:10:28 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:28 volumio volumio[12611]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Aug 28 14:10:28 volumio volumio[12611]: info: FusionDsp loaded Aug 28 14:10:28 volumio volumio[12611]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:28 volumio volumio[12611]: info: FusionDsp - --[object Object] Aug 28 14:10:28 volumio volumio[12611]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 28 14:10:28 volumio volumio[12611]: info: Adding Signal Path Element [object Object] Aug 28 14:10:28 volumio volumio[12611]: info: Adding fusiondspeq DSP Signal Path Element Aug 28 14:10:28 volumio volumio[12611]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Aug 28 14:10:28 volumio volumio[12611]: info: FusionDsp - PEQ graph server listening on port 10015 Aug 28 14:10:28 volumio volumio[12611]: error: FusionDsp - Reload WebSocket error: [object Object] Aug 28 14:10:28 volumio sudo[12849]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 28 14:10:28 volumio sudo[12849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:28 volumio sudo[12849]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:29 volumio volumio[12611]: info: Preload queue cleared Aug 28 14:10:29 volumio volumio[12611]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::ClearQueue Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::stop Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::clearPlayQueue Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::saveQueue Aug 28 14:10:29 volumio volumio[12611]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::addQueueItems Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::addQueueItems Aug 28 14:10:29 volumio volumio[12611]: info: Preload queue cleared Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=3a6f505961f0acf75501b3eff9478882 Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-conn] Using previously assigned device Id for lorebern@Bernhards-MBP: a69a1439-d6b8-46c1-b06f-7b0b5dd0d2d1 Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=937d3486b5d4a8a421662555d22e1b10 Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-conn] Returning existing auth promise Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-conn] Returning existing auth promise Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-conn] Login successful: lorebern@Bernhards-MBP Aug 28 14:10:29 volumio volumio[12611]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::saveQueue Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::updateTrackBlock Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::getTrackBlock Aug 28 14:10:29 volumio volumio[12611]: info: CoreCommandRouter::volumioPlay Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::play index 2 Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::addQueueItems Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::addQueueItems Aug 28 14:10:29 volumio volumio[12611]: info: Preload queue cleared Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=e3b1bcd8c3873ac9308e81756672edac Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=54568f9619895778097278ae115d644b Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=18187a9b694378895659423c1c2a6c31 Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=2bcba00d9e6a51aa023a2a3b8436b893 Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=04ad5855efc325a369d4c3e3028f632f Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=36103669638e7aee6bcd38b026d81379 Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=ea83a6f7fc3fc2ce3716dea7c74069c6 Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=bd5b9f5878bb8a9343c772f94321de94 Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=f8dc8a028c073e8e4489d435d7673725 Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=724c5bfaea279d0c45c2c905e5d36bfe Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=9d630b0e7cc42b1193a8bbdf76d2e27c Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=1f13a10b4a3efe4bf420aaf165241cfa Aug 28 14:10:29 volumio volumio[12611]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:10:29 volumio volumio[12611]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e in service jellyfin Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/songs@albumId=fe466fa9bfa5c501c3b7edaf33bd5d47/song@songId=d5b185828cb672f133379d7f41c2432e Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::stop Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::play index undefined Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::getTrack 2 Aug 28 14:10:29 volumio volumio[12611]: info: CoreStateMachine::startPlaybackTimer Aug 28 14:10:29 volumio volumio[12611]: info: CorePlayQueue::getTrack 2 Aug 28 14:10:29 volumio volumio[12611]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=1c9e59cb0b99079fdf97e2bf7d1ae4d5 Aug 28 14:10:29 volumio volumio[12611]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:10:29 volumio volumio[12611]: Error: No media streams found for song 03-Puerto Rico Aug 28 14:10:29 volumio volumio[12611]: at PlayController._PlayController_getStreamUrl (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:241:15) Aug 28 14:10:29 volumio volumio[12611]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:78:234) Aug 28 14:10:29 volumio volumio[12611]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 14:10:29 volumio volumio[12611]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:10:29 volumio sudo[12865]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 14:09' Aug 28 14:10:29 volumio sudo[12865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:30 volumio sudo[12865]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:30 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:30.094+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Aug 28 14:10:30 volumio volumio-remote-updater[730]: [2026-08-28 14:10:30] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 28 14:10:30 volumio volumio-remote-updater[730]: [2026-08-28 14:10:30] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 28 14:10:30 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 28 14:10:30 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:30.097+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 28 14:10:30 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 28 14:10:30 volumio systemd[1]: volumio.service: Consumed 14.913s CPU time. Aug 28 14:10:30 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Aug 28 14:10:30 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Aug 28 14:10:30 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Aug 28 14:10:30 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Aug 28 14:10:30 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Aug 28 14:10:30 volumio systemd[1]: volumio.service: Consumed 14.913s CPU time. Aug 28 14:10:30 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Aug 28 14:10:30 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Aug 28 14:10:31 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:31.098+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 28 14:10:31 volumio volumio[12883]: info: ------------------------------------------- Aug 28 14:10:31 volumio volumio[12883]: info: ----- Volumio3 ---- Aug 28 14:10:31 volumio volumio[12883]: info: ------------------------------------------- Aug 28 14:10:31 volumio volumio[12883]: info: ----- System startup ---- Aug 28 14:10:31 volumio volumio[12883]: info: ------------------------------------------- Aug 28 14:10:31 volumio volumio[12883]: info: MYVOLUMIO Environment detected Aug 28 14:10:31 volumio volumio[12883]: info: Plugin folders cleanup Aug 28 14:10:31 volumio volumio[12883]: info: Scanning into folder /volumio/app/plugins/ Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category audio_interface Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category miscellanea Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category music_service Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category plugins.json Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category system_controller Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category user_interface Aug 28 14:10:31 volumio volumio[12883]: info: Scanning into folder /data/plugins/ Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category audio_interface Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category music_service Aug 28 14:10:31 volumio volumio[12883]: info: Scanning category user_interface Aug 28 14:10:31 volumio volumio[12883]: info: Plugin folders cleanup completed Aug 28 14:10:31 volumio volumio[12883]: info: ------------------------------------------- Aug 28 14:10:31 volumio volumio[12883]: info: ----- Core plugins startup ---- Aug 28 14:10:31 volumio volumio[12883]: info: ------------------------------------------- Aug 28 14:10:31 volumio volumio[12883]: info: Loading plugins from folder /volumio/app/plugins/ Aug 28 14:10:31 volumio volumio[12883]: info: Adding plugin upnp to MyMusic Plugins Aug 28 14:10:31 volumio volumio[12883]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 28 14:10:31 volumio volumio[12883]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 28 14:10:31 volumio volumio[12883]: info: Loading plugins from folder /data/plugins/ Aug 28 14:10:31 volumio volumio[12883]: info: Loading plugin "system"... Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "appearance"... Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "network"... Aug 28 14:10:32 volumio volumio[12883]: info: Refreshing Cached IP Addresses Aug 28 14:10:32 volumio sudo[12911]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 28 14:10:32 volumio sudo[12911]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:32 volumio sudo[12913]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 28 14:10:32 volumio sudo[12913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "services"... Aug 28 14:10:32 volumio sudo[12911]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "volumio5onboarding"... Aug 28 14:10:32 volumio sudo[12913]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:32 volumio sudo[12920]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 28 14:10:32 volumio sudo[12920]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "alsa_controller"... Aug 28 14:10:32 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "wizard"... Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "networkfs"... Aug 28 14:10:32 volumio volumio[12883]: info: Cannot mount NAS WernerClasicMusik at system boot, trial number 1 ,retrying in 5 seconds Aug 28 14:10:32 volumio volumio[12883]: info: Cannot mount NAS WernerFlacMusik at system boot, trial number 1 ,retrying in 5 seconds Aug 28 14:10:32 volumio volumio[12883]: info: Starting Udev Watcher for removable devices Aug 28 14:10:32 volumio volumio[12883]: info: Ignoring mount for partition: boot Aug 28 14:10:32 volumio volumio[12883]: info: Ignoring mount for partition: volumio Aug 28 14:10:32 volumio volumio[12883]: info: Ignoring mount for partition: volumio_data Aug 28 14:10:32 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "volumio_command_line_client"... Aug 28 14:10:32 volumio volumio[12883]: info: Plugin upnp is not enabled Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "my_music"... Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "mpd"... Aug 28 14:10:32 volumio volumio[12883]: info: Plugin upnp_browser is not enabled Aug 28 14:10:32 volumio volumio[12883]: info: Loading plugin "alarm-clock"... Aug 28 14:10:33 volumio volumio[12883]: info: Plugin airplay_emulation is not enabled Aug 28 14:10:33 volumio volumio[12883]: info: Loading plugin "last_100"... Aug 28 14:10:33 volumio volumio[12883]: info: Loading plugin "webradio"... Aug 28 14:10:33 volumio volumio[12883]: info: Loading plugin "i2s_dacs"... Aug 28 14:10:33 volumio volumio[12883]: info: Loading plugin "volumiodiscovery"... Aug 28 14:10:33 volumio volumio[12883]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:33 volumio volumio[12883]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:33 volumio volumio[12883]: *** WARNING *** For more information see Aug 28 14:10:33 volumio volumio[12883]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:33 volumio volumio[12883]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:33 volumio node[12883]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:33 volumio volumio[12883]: *** WARNING *** For more information see Aug 28 14:10:33 volumio node[12883]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:33 volumio node[12883]: *** WARNING *** For more information see Aug 28 14:10:33 volumio node[12883]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 28 14:10:33 volumio node[12883]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 28 14:10:33 volumio node[12883]: *** WARNING *** For more information see Aug 28 14:10:33 volumio volumio[12883]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 28 14:10:33 volumio volumio[12883]: info: Discovery: Started advertising with name: Volumio Aug 28 14:10:33 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 28 14:10:33 volumio volumio[12883]: info: Loading plugin "jellyfin"... Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "now_playing"... Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "outputs"... Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "albumart"... Aug 28 14:10:34 volumio volumio[12883]: info: Plugin example_plugin is not enabled Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "inputs"... Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "updater_comm"... Aug 28 14:10:34 volumio volumio[12883]: info: Plugin mpdemulation is not enabled Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "rest_api"... Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "websocket"... Aug 28 14:10:34 volumio volumio[12883]: info: Starting Socket.io Server version 1.7.4 Aug 28 14:10:34 volumio volumio[12883]: info: Loading plugin "fusiondsp"... Aug 28 14:10:35 volumio volumio-remote-updater[730]: [2026-08-28 14:10:35] [connect] Successful connection Aug 28 14:10:35 volumio volumio[12883]: info: Applying required configuration parameters for plugin fusiondsp Aug 28 14:10:35 volumio volumio[12946]: Forking 3 albumart workers Aug 28 14:10:35 volumio volumio[12883]: info: Loading plugin "Systeminfo"... Aug 28 14:10:35 volumio volumio[12883]: info: Loading i18n strings for locale de Aug 28 14:10:35 volumio volumio[12883]: Updating browse sources language Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::initPlayerControls Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: Express server listening on port 3000 Aug 28 14:10:35 volumio volumio[12883]: [Metrics] WebUI: 4s 305.43ms Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::resetVolumioState Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::getcurrentVolume Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::volumioRetrievevolume Aug 28 14:10:35 volumio volumio[12883]: info: Volumio Network Manager: Network status updated: 2 Aug 28 14:10:35 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 28 14:10:35 volumio volumio[12883]: verbose: New Socket.io Connection to 192.168.178.28 from 192.168.178.22 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 1 Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:35 volumio volumio[12883]: info: Executing start script for DAC IQaudIO DAC Plus Aug 28 14:10:35 volumio volumio[12883]: info: Reloading queue from file Aug 28 14:10:35 volumio volumio[12883]: info: VolumeController:: Volume=100 Mute =false Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::pushState Aug 28 14:10:35 volumio sudo[12920]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:35 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::updateTrackBlock Aug 28 14:10:35 volumio volumio[12883]: info: CorePlayQueue::getTrackBlock Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::volumioRetrievevolume Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::setRepeat null single undefined Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::pushState Aug 28 14:10:35 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::setRandom null Aug 28 14:10:35 volumio volumio[12883]: info: CoreStateMachine::pushState Aug 28 14:10:35 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:35 volumio volumio[12883]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:35 volumio volumio[12883]: info: Setting Device type: Raspberry PI Aug 28 14:10:35 volumio volumio[12883]: info: DAC script executed Aug 28 14:10:35 volumio volumio[12883]: info: Completed loading Core Plugins Aug 28 14:10:35 volumio volumio[12883]: info: Preparing to generate the ALSA configuration file Aug 28 14:10:35 volumio volumio[12883]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 28 14:10:35 volumio volumio[12883]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Aug 28 14:10:35 volumio volumio[12883]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 28 14:10:35 volumio volumio[12883]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 28 14:10:35 volumio volumio[12883]: info: Reading ALSA contributions from plugins. Aug 28 14:10:36 volumio volumio[12956]: Starting albumart workers Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: Getting this device information Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:36 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 2 Aug 28 14:10:36 volumio volumio-remote-updater[730]: [2026-08-28 14:10:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1787919035 101 Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 28 14:10:36 volumio volumio[12883]: info: VolumeController:: Volume=100 Mute =false Aug 28 14:10:36 volumio volumio[12883]: info: CoreStateMachine::pushState Aug 28 14:10:36 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioPushState Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: adding dab053da-dd83-465d-bebf-e3c7b3e8ba2e Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: Found device Volumio Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:36 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:36 volumio volumio[12957]: Starting albumart workers Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to 192.168.178.28:3000 from 192.168.178.22 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: this is already registered, dab053da-dd83-465d-bebf-e3c7b3e8ba2e Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: Found device Volumio Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:36 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 14:10:36 volumio volumio[12958]: Starting albumart workers Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 28 14:10:36 volumio volumio[12883]: info: Asound.conf file unchanged, so no further update is needed Aug 28 14:10:36 volumio volumio[12883]: info: Output device has changed, restarting MPD Aug 28 14:10:36 volumio volumio[12883]: info: ___________ START PLUGINS ___________ Aug 28 14:10:36 volumio sudo[13004]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 14:10:36 volumio sudo[13004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:36 volumio sudo[13006]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 14:10:36 volumio sudo[13004]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:36 volumio sudo[13006]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:36 volumio volumio[12883]: info: ControllerMpd::onStart: Initializing MPD Aug 28 14:10:36 volumio volumio[12883]: info: Creating MPD Configuration file Aug 28 14:10:36 volumio sudo[13009]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 28 14:10:36 volumio sudo[13009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:36 volumio sudo[13014]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 14:10:36 volumio sudo[13014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 14:10:36 volumio volumio[12883]: info: [1787919036248] CoreMusicLibrary::Adding element Last_100 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:36 volumio sudo[13014]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 14:10:36 volumio volumio[12883]: info: [1787919036262] CoreMusicLibrary::Adding element Webradio Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:36 volumio sudo[13015]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 14:10:36 volumio sudo[13015]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:36 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 28 14:10:36 volumio sudo[13009]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:10:36 volumio volumio[12883]: info: Initializing BBC Radios Aug 28 14:10:36 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 14:10:36 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 14:10:36 volumio systemd[1]: mpd.service: Consumed 1.323s CPU time. Aug 28 14:10:36 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 14:10:36 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 14:10:36 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 14:10:36 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:36.340+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.178.22:53027 @ 0x24b6660" available=true connected=true macAddress=e4:5f:01:1b:18:f9 ip4Address=192.168.178.28/24 ip6Address= ssid="FRITZ!Box 7530 DM" Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: Getting this device information Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:36 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 28 14:10:36 volumio volumio[12883]: info: [1787919036404] CoreMusicLibrary::Adding element Jellyfin Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:36 volumio volumio[12883]: Cannot find translation for source Jellyfin Aug 28 14:10:36 volumio volumio[12883]: info: [jellyfin] Initialized plugin with device info: {"host":"http://192.168.178.28","id":"dab053da-dd83-465d-bebf-e3c7b3e8ba2e","name":"Volumio","serviceName":"Volumio","state":{"albumart":"http://192.168.178.28/albumart?sourceicon=music_service%2Fjellyfin%2Fdist%2Fassets%2Fimages%2Fsong.png","artist":"","mute":false,"status":"stop","track":"01-Don't Cry For Love","volume":100},"type":"device"} Aug 28 14:10:36 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 14:10:36 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 14:10:36 volumio volumio[12883]: info: [now-playing] ConfigUpdater: config is up to date. Aug 28 14:10:36 volumio volumio[12883]: info: FusionDsp - CamillaDSP binary found. Aug 28 14:10:36 volumio volumio[12883]: info: Loading i18n strings for locale de Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: FusionDsp - mixtype--------------------- Hardware Aug 28 14:10:36 volumio volumio[12883]: info: Volumio Calling Home Aug 28 14:10:36 volumio sudo[13032]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 14:10:36 volumio sudo[13032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 14:10:36 volumio sudo[13032]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:36 volumio volumio[12883]: info: Preparing to generate the ALSA configuration file Aug 28 14:10:36 volumio volumio[12883]: info: [now-playing] App is listening on port 4004. Aug 28 14:10:36 volumio volumio[12883]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: Getting this device information Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:36 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 28 14:10:36 volumio volumio[12883]: info: Received Get System Info Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 14:10:36 volumio volumio[12883]: info: Discovery: Getting this device information Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:36 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:36 volumio volumio[12883]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 28 14:10:36 volumio volumio[12883]: info: Reading ALSA contributions from plugins. Aug 28 14:10:36 volumio volumio[12883]: info: MPD Permissions set Aug 28 14:10:36 volumio volumio[12883]: info: MPD Permissions set Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 14:10:36 volumio volumio[12883]: info: Volumio called home Aug 28 14:10:36 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 28 14:10:37 volumio volumio[12883]: verbose: New Socket.io Connection to 192.168.178.28:3000 from 192.168.178.22 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 28 14:10:37 volumio volumio[12883]: info: [jellyfin-poller] Polled http://192.168.178.20:8096: online Aug 28 14:10:37 volumio volumio[12883]: info: Asound.conf file unchanged, so no further update is needed Aug 28 14:10:37 volumio volumio[12883]: info: Output device has changed, restarting MPD Aug 28 14:10:37 volumio sudo[13068]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 14:10:37 volumio sudo[13068]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:37 volumio sudo[13070]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 14:10:37 volumio sudo[13070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:37 volumio sudo[13068]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:37 volumio volumio[12883]: info: MPD Permissions set Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:37 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 14:10:37 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 14:10:37 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 14:10:37 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 14:10:37 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:37 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:37 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 14:10:37 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 14:10:37 volumio sudo[13079]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 14:10:37 volumio sudo[13079]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 14:10:37 volumio sudo[13079]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:37 volumio volumio[12883]: info: Cannot mount NAS WernerClasicMusik at system boot, trial number 2 ,retrying in 5 seconds Aug 28 14:10:37 volumio volumio[12883]: info: Cannot mount NAS WernerFlacMusik at system boot, trial number 2 ,retrying in 5 seconds Aug 28 14:10:37 volumio volumio5-onboarding[1635]: time=2026-08-28T14:10:37.725+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 28 14:10:37 volumio volumio[12883]: verbose: New Socket.io Connection to 192.168.178.28 from 192.168.178.22 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:37 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:37 volumio volumio[12883]: info: Listing playlists Aug 28 14:10:37 volumio volumio[12883]: info: CoreCommandRouter::volumioGetQueue Aug 28 14:10:37 volumio volumio[12883]: info: CoreStateMachine::getQueue Aug 28 14:10:37 volumio volumio[12883]: info: CorePlayQueue::getQueue Aug 28 14:10:38 volumio volumio[12883]: verbose: New Socket.io Connection to 192.168.178.28 from 192.168.178.20 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.6 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 Aug 28 14:10:38 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:10:38 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:10:38 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 14:10:38 volumio volumio[12883]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 14:10:38 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 14:10:38 volumio volumio[12883]: info: CoreCommandRouter::volumioGetQueue Aug 28 14:10:38 volumio volumio[12883]: info: CoreStateMachine::getQueue Aug 28 14:10:38 volumio volumio[12883]: info: CorePlayQueue::getQueue Aug 28 14:10:38 volumio volumio[12883]: info: Listing playlists Aug 28 14:10:38 volumio mpd[13081]: 2026-08-28T14:10:38 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 28 14:10:38 volumio systemd[1]: Started mpd.service - Music Player Daemon. Aug 28 14:10:38 volumio sudo[13006]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:38 volumio sudo[13015]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:38 volumio sudo[13070]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:38 volumio volumio[12883]: info: Completed starting Core Plugins Aug 28 14:10:38 volumio volumio[12883]: info: ------------------------------------------- Aug 28 14:10:38 volumio volumio[12883]: info: ----- MyVolumio plugins startup ---- Aug 28 14:10:38 volumio volumio[12883]: info: ------------------------------------------- Aug 28 14:10:38 volumio volumio[12883]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 28 14:10:38 volumio volumio[12883]: error: MPD error: The expression evaluated to a falsy value: Aug 28 14:10:38 volumio volumio[12883]: assert.ok(self.idling) Aug 28 14:10:38 volumio volumio[12883]: error: The expression evaluated to a falsy value: Aug 28 14:10:38 volumio volumio[12883]: assert.ok(self.idling) Aug 28 14:10:38 volumio volumio[12883]: error: MPD error: The expression evaluated to a falsy value: Aug 28 14:10:38 volumio volumio[12883]: assert.ok(self.idling) Aug 28 14:10:38 volumio volumio[12883]: error: The expression evaluated to a falsy value: Aug 28 14:10:38 volumio volumio[12883]: assert.ok(self.idling) Aug 28 14:10:38 volumio volumio[12883]: info: MPD running with PID13081 Aug 28 14:10:38 volumio volumio[12883]: ,establishing connection Aug 28 14:10:38 volumio volumio[12883]: error: updateQueue error: null Aug 28 14:10:38 volumio volumio[12883]: error: updateQueue error: null Aug 28 14:10:42 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:10:42 volumio volumio[12883]: info: [jellyfin-browse] browseUri: jellyfin Aug 28 14:10:42 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:42 volumio volumio[12883]: info: Cannot mount NAS WernerClasicMusik at system boot, trial number 3 ,retrying in 5 seconds Aug 28 14:10:42 volumio volumio[12883]: info: Cannot mount NAS WernerFlacMusik at system boot, trial number 3 ,retrying in 5 seconds Aug 28 14:10:43 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:10:43 volumio volumio[12883]: info: [jellyfin-browse] browseUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9 Aug 28 14:10:43 volumio volumio[12883]: info: [jellyfin-conn] Using previously assigned device Id for lorebern@Bernhards-MBP: a69a1439-d6b8-46c1-b06f-7b0b5dd0d2d1 Aug 28 14:10:43 volumio volumio[12883]: info: [jellyfin-conn] Login successful: lorebern@Bernhards-MBP Aug 28 14:10:43 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"startIndex":0,"limit":47,"sortBy":["SortName"],"sortOrder":["Ascending"]} Aug 28 14:10:43 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/UserViews?userId=6ae504d5eec5466b91368ceef326d15b Aug 28 14:10:43 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":11,"sortBy":["DateCreated","SortName"],"sortOrder":["Descending","Ascending"],"includeItemTypes":["MusicAlbum"]} Aug 28 14:10:43 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&limit=11&recursive=true&sortOrder=Descending&sortOrder=Ascending&parentId=8a05b0252259a1dbd62df97522638439&includeItemTypes=MusicAlbum&sortBy=DateCreated&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:10:43 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:43 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:43 volumio volumio[12883]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 28 14:10:45 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:10:45 volumio volumio[12883]: info: [jellyfin-browse] browseUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439 Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":11,"sortBy":["DateCreated","SortName"],"sortOrder":["Descending","Ascending"],"includeItemTypes":["MusicAlbum"]} Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":5,"sortBy":["DatePlayed","SortName"],"sortOrder":["Descending","Ascending"],"fields":["MediaSources"],"filters":["IsPlayed"],"includeItemTypes":["Audio"]} Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":5,"sortBy":["PlayCount","SortName"],"sortOrder":["Descending","Ascending"],"fields":["MediaSources"],"filters":["IsPlayed"],"includeItemTypes":["Audio"]} Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":5,"sortBy":["SortName"],"sortOrder":["Ascending"],"filters":["IsFavorite"]} Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":5,"sortBy":["SortName"],"sortOrder":["Ascending"],"filters":["IsFavorite"],"includeItemTypes":["MusicAlbum"]} Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":5,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"filters":["IsFavorite"],"includeItemTypes":["Audio"]} Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&limit=5&recursive=true&sortOrder=Ascending&parentId=8a05b0252259a1dbd62df97522638439&includeItemTypes=MusicAlbum&filters=IsFavorite&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&limit=11&recursive=true&sortOrder=Descending&sortOrder=Ascending&parentId=8a05b0252259a1dbd62df97522638439&includeItemTypes=MusicAlbum&sortBy=DateCreated&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&limit=5&recursive=true&sortOrder=Ascending&parentId=8a05b0252259a1dbd62df97522638439&fields=MediaSources&includeItemTypes=Audio&filters=IsFavorite&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&limit=5&recursive=true&sortOrder=Descending&sortOrder=Ascending&parentId=8a05b0252259a1dbd62df97522638439&fields=MediaSources&includeItemTypes=Audio&filters=IsPlayed&sortBy=PlayCount&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&limit=5&recursive=true&sortOrder=Descending&sortOrder=Ascending&parentId=8a05b0252259a1dbd62df97522638439&fields=MediaSources&includeItemTypes=Audio&filters=IsPlayed&sortBy=DatePlayed&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:10:45 volumio volumio[12883]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 28 14:10:45 volumio volumio[12883]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Aug 28 14:10:45 volumio volumio[12883]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 28 14:10:45 volumio volumio[12883]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 28 14:10:45 volumio volumio[12883]: info: camilladsp service started and running in background, instance 1 Aug 28 14:10:45 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:10:45 volumio volumio[12883]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Aug 28 14:10:45 volumio volumio[12883]: info: FusionDsp loaded Aug 28 14:10:45 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:45 volumio volumio[12883]: info: FusionDsp - --[object Object] Aug 28 14:10:45 volumio volumio[12883]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 28 14:10:45 volumio volumio[12883]: info: Adding Signal Path Element [object Object] Aug 28 14:10:45 volumio volumio[12883]: info: Adding fusiondspeq DSP Signal Path Element Aug 28 14:10:45 volumio volumio[12883]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Aug 28 14:10:45 volumio volumio[12883]: info: FusionDsp - PEQ graph server listening on port 10015 Aug 28 14:10:45 volumio volumio[12883]: error: FusionDsp - Reload WebSocket error: [object Object] Aug 28 14:10:45 volumio sudo[13127]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 28 14:10:45 volumio sudo[13127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:45 volumio sudo[13127]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:45 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Artists?startIndex=0&limit=5&parentId=8a05b0252259a1dbd62df97522638439&filters=IsFavorite&imageTypeLimit=1&enableImageTypes=Primary&userId=6ae504d5eec5466b91368ceef326d15b&sortBy=SortName&sortOrder=Ascending Aug 28 14:10:45 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:45 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:45 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=fe3404a1f183f3f5768035bc444a4647 Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=cbe9b8e389532e2306eedc30595ce38e Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=7cae04d6056c7d3eff033ba82ae6da00 Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=c749b6de8970eee58219b41cff950a92 Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=a55686ad3de63b2d2bc107c9771a254b Aug 28 14:10:45 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=006f4285b03e5c0cc5cf58df37072743 Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=c597f96351c6ce4f69e5e6838706a0bf Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=acfbfc9dc525839149837fdfc6b6e260 Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=91307c4d4a3e84d359385bf21d7011df Aug 28 14:10:45 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=2e67b9b41dde2d0b4815bd4af22957c3 Aug 28 14:10:46 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=006f4285b03e5c0cc5cf58df37072743 in service jellyfin Aug 28 14:10:46 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=006f4285b03e5c0cc5cf58df37072743 Aug 28 14:10:46 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=c597f96351c6ce4f69e5e6838706a0bf in service jellyfin Aug 28 14:10:46 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=c597f96351c6ce4f69e5e6838706a0bf Aug 28 14:10:46 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=acfbfc9dc525839149837fdfc6b6e260 in service jellyfin Aug 28 14:10:46 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=acfbfc9dc525839149837fdfc6b6e260 Aug 28 14:10:46 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=91307c4d4a3e84d359385bf21d7011df in service jellyfin Aug 28 14:10:46 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=91307c4d4a3e84d359385bf21d7011df Aug 28 14:10:46 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=2e67b9b41dde2d0b4815bd4af22957c3 in service jellyfin Aug 28 14:10:46 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/song@songId=2e67b9b41dde2d0b4815bd4af22957c3 Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 28 14:10:47 volumio volumio[12883]: info: Adding plugin bluetooth to MyMusic Plugins Aug 28 14:10:47 volumio volumio[12883]: info: Adding plugin multiroom to MyMusic Plugins Aug 28 14:10:47 volumio volumio[12883]: info: Adding plugin metavolumio to MyMusic Plugins Aug 28 14:10:47 volumio volumio[12883]: info: Adding plugin cd_controller to MyMusic Plugins Aug 28 14:10:47 volumio volumio[12883]: info: Adding plugin qobuzconnect to MyMusic Plugins Aug 28 14:10:47 volumio volumio[12883]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 28 14:10:47 volumio volumio[12883]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 28 14:10:47 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:47 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:47 volumio volumio[12883]: info: Starting MyVolumio Remote Streaming Endpoints Aug 28 14:10:47 volumio volumio[12883]: info: MyVolumio login type: Token Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 28 14:10:47 volumio volumio[12883]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 28 14:10:48 volumio volumio[12883]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 28 14:10:48 volumio volumio[12883]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 28 14:10:48 volumio volumio[12883]: info: Streaming services startup Aug 28 14:10:48 volumio volumio[12883]: info: Starting Streaming Daemon Aug 28 14:10:48 volumio sudo[13130]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 28 14:10:48 volumio sudo[13130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:48 volumio volumio[12883]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 28 14:10:48 volumio sudo[13130]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:48 volumio volumio[12883]: info: Cannot mount NAS WernerClasicMusik at system boot, trial number 4 ,retrying in 5 seconds Aug 28 14:10:48 volumio volumio[12883]: info: Cannot mount NAS WernerFlacMusik at system boot, trial number 4 ,retrying in 5 seconds Aug 28 14:10:48 volumio volumio[12883]: error: Cannot start Volumio Streaming Daemon Aug 28 14:10:48 volumio volumio[12883]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 28 14:10:48 volumio volumio[12883]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 28 14:10:48 volumio volumio[12883]: error: MyVolumio Custom Token format not valid, refreshing it Aug 28 14:10:49 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:10:49 volumio volumio[12883]: info: [jellyfin-browse] browseUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/artists@parentId=8a05b0252259a1dbd62df97522638439 Aug 28 14:10:49 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":47,"sortBy":["SortName"],"sortOrder":["Ascending"]} Aug 28 14:10:49 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Genres?startIndex=0&limit=47&parentId=8a05b0252259a1dbd62df97522638439&imageTypeLimit=1&enableImageTypes=Primary&userId=6ae504d5eec5466b91368ceef326d15b&sortBy=SortName&sortOrder=Ascending Aug 28 14:10:49 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8a05b0252259a1dbd62df97522638439","startIndex":0,"limit":47,"sortBy":["SortName"],"sortOrder":["Ascending"]} Aug 28 14:10:49 volumio volumio[12883]: info: MyVolumio login type: Token Aug 28 14:10:49 volumio volumio[12883]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 28 14:10:50 volumio volumio[12883]: info: MyVolumio token set successfully Aug 28 14:10:50 volumio volumio[12883]: info: MYVOLUMIO: Adding device Aug 28 14:10:50 volumio volumio[12883]: info: MYVOLUMIO: Evaluating Server Aug 28 14:10:50 volumio volumio[12883]: info: MyVolumio status changed Aug 28 14:10:50 volumio volumio[12883]: info: Streaming services startup Aug 28 14:10:50 volumio volumio[12883]: info: Starting Streaming Daemon Aug 28 14:10:50 volumio volumio[12883]: info: Removing browser output: myVolumio user plan is not superstar Aug 28 14:10:50 volumio volumio[12883]: info: Removing audio output: Aug 28 14:10:50 volumio volumio[12883]: info: Stoppping Tunnel 1 Aug 28 14:10:50 volumio sudo[13157]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 28 14:10:50 volumio sudo[13157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:50 volumio sudo[13159]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 28 14:10:50 volumio sudo[13159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 14:10:50 volumio sudo[13157]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio volumio[12883]: error: Cannot start Volumio Streaming Daemon Aug 28 14:10:50 volumio volumio[12883]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 28 14:10:50 volumio volumio[12883]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 28 14:10:50 volumio sudo[13159]: pam_unix(sudo:session): session closed for user root Aug 28 14:10:50 volumio volumio[12883]: info: Remote SSH Stopped Aug 28 14:10:51 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Artists?startIndex=0&limit=47&parentId=8a05b0252259a1dbd62df97522638439&imageTypeLimit=1&enableImageTypes=Primary&userId=6ae504d5eec5466b91368ceef326d15b&sortBy=SortName&sortOrder=Ascending Aug 28 14:10:51 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:51 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:10:51 volumio volumio[12883]: info: Setting Geolocation for MyVolumio to eu4 Aug 28 14:10:51 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:51 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:51 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:51 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 14:10:51 volumio volumio[12883]: info: Systeminfo: --[object Object] Aug 28 14:10:51 volumio volumio[12883]: info: Systeminfo web UI listening on port 12334 Aug 28 14:10:51 volumio volumio[12883]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 28 14:10:52 volumio volumio[12883]: info: Updating MyVolumio device info Aug 28 14:10:52 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:52 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:52 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:52 volumio volumio[12883]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 28 14:10:53 volumio volumio[12883]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 28 14:10:53 volumio volumio[12883]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 28 14:10:55 volumio volumio[12883]: info: MYVOLUMIO: Adding device Aug 28 14:10:55 volumio volumio[12883]: info: MYVOLUMIO: Evaluating Server Aug 28 14:10:56 volumio volumio[12883]: info: Setting Geolocation for MyVolumio to eu4 Aug 28 14:10:56 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:56 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:56 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:56 volumio volumio[12883]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 28 14:10:57 volumio volumio[12883]: info: Updating MyVolumio device info Aug 28 14:10:57 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:57 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:57 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:10:57 volumio volumio[12883]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 28 14:11:02 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 28 14:11:02 volumio volumio[12883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 28 14:11:02 volumio volumio[12883]: info: CoreCommandRouter::volumioGetState Aug 28 14:11:02 volumio volumio[12883]: info: CorePlayQueue::getTrack 0 Aug 28 14:11:06 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:11:06 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:11:06 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 14:11:06 volumio volumio-remote-updater[730]: Test mode disabled Aug 28 14:11:06 volumio volumio-remote-updater[730]: Alpha mode disabled Aug 28 14:11:06 volumio volumio-remote-updater[730]: Alpha legacy test mode disabled Aug 28 14:11:06 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 28 14:11:06 volumio volumio[12883]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Aug 28 14:11:06 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::volumioGetBrowseSources Aug 28 14:11:07 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 28 14:11:08 volumio volumio[12883]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 28 14:11:08 volumio volumio[12883]: info: Completed starting MyVolumio Plugin Aug 28 14:11:08 volumio volumio[12883]: [Metrics] CommandRouter: 36s 928.27ms Aug 28 14:11:08 volumio volumio[12883]: info: CoreCommandRouter::volumiosetStartupVolume Aug 28 14:11:08 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 14:11:08 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 14:11:08 volumio volumio[12883]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:11:08 volumio volumio[12883]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:11:08 volumio volumio[12883]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Aug 28 14:11:08 volumio volumio[12883]: info: FusionDsp - ---- read samplerate from file: 44100 Aug 28 14:11:08 volumio volumio[12883]: info: camilladsp stopping service pid 13120... Aug 28 14:11:09 volumio volumio[12883]: grep: /proc/13120/cmdline: binary file matches Aug 28 14:11:09 volumio volumio[12883]: grep: /proc/13120/cmdline: binary file matches Aug 28 14:11:09 volumio volumio[12883]: grep: /proc/13120/cmdline: binary file matches Aug 28 14:11:09 volumio volumio[12883]: grep: /proc/13120/cmdline: binary file matches Aug 28 14:11:09 volumio volumio[12883]: grep: /proc/13120/cmdline: binary file matches Aug 28 14:11:09 volumio volumio[12883]: info: camilladsp service terminated, instance 1 Aug 28 14:11:09 volumio volumio[12883]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 28 14:11:09 volumio volumio[12883]: info: camilladsp service started and running in background, instance 1 Aug 28 14:11:09 volumio volumio[12883]: info: camilladsp respawn in 100 ms (attempt 1/10) Aug 28 14:11:09 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 28 14:11:09 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 28 14:11:09 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 28 14:11:13 volumio volumio[12883]: info: camilladsp respawn in 200 ms (attempt 2/10) Aug 28 14:11:15 volumio volumio[12883]: info: BOOT COMPLETED Aug 28 14:11:36 volumio volumio[12883]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Aug 28 14:11:36 volumio volumio[12883]: info: [jellyfin-browse] browseUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a Aug 28 14:11:36 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"6ae504d5eec5466b91368ceef326d15b","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"921f4e9528a7ad22c0ed8c92eed8e79a","startIndex":0,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"includeItemTypes":["Audio"]} Aug 28 14:11:36 volumio volumio[12883]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.178.20:8096/Items?userId=6ae504d5eec5466b91368ceef326d15b&startIndex=0&recursive=true&sortOrder=Ascending&parentId=921f4e9528a7ad22c0ed8c92eed8e79a&fields=MediaSources&includeItemTypes=Audio&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Aug 28 14:11:37 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=49f90d35ce8ab7d7d9e376d519aa70fd Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=8f5f1806dae8510b9f55872740f9be54 Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fb6506fbeef71fefa5e97a62ab9b57d Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=151178b130fa51bde80545a912c44523 Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fbb750299542c3fc32722d8f78dbc2c Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=4cd05e8f06b5507438a9933202bffae5 Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=86086386765bc73084cc59076f65482d Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=3b23ca5b47502d5891d4aa7ebb18c1f1 Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=648088fd1ff0f5244d25ac69ca417222 Aug 28 14:11:37 volumio volumio[12883]: info: Preloading song: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=40bcebae6eff6144ca718d24b0592014 Aug 28 14:11:37 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:11:42 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:11:42 volumio volumio[12883]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::ClearQueue Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::stop Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::clearPlayQueue Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::saveQueue Aug 28 14:11:42 volumio volumio[12883]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::addQueueItems Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::addQueueItems Aug 28 14:11:42 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=49f90d35ce8ab7d7d9e376d519aa70fd Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=49f90d35ce8ab7d7d9e376d519aa70fd in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=49f90d35ce8ab7d7d9e376d519aa70fd Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=8f5f1806dae8510b9f55872740f9be54 Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=8f5f1806dae8510b9f55872740f9be54 in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=8f5f1806dae8510b9f55872740f9be54 Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fb6506fbeef71fefa5e97a62ab9b57d Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fb6506fbeef71fefa5e97a62ab9b57d in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fb6506fbeef71fefa5e97a62ab9b57d Aug 28 14:11:42 volumio volumio[12883]: info: CoreCommandRouter::volumioPushQueue Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::saveQueue Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::updateTrackBlock Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::getTrackBlock Aug 28 14:11:42 volumio volumio[12883]: info: CoreCommandRouter::volumioPlay Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::play index 2 Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::addQueueItems Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::addQueueItems Aug 28 14:11:42 volumio volumio[12883]: info: Preload queue cleared Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=151178b130fa51bde80545a912c44523 Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=151178b130fa51bde80545a912c44523 in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=151178b130fa51bde80545a912c44523 Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fbb750299542c3fc32722d8f78dbc2c Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fbb750299542c3fc32722d8f78dbc2c in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=1fbb750299542c3fc32722d8f78dbc2c Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=4cd05e8f06b5507438a9933202bffae5 Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=4cd05e8f06b5507438a9933202bffae5 in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=4cd05e8f06b5507438a9933202bffae5 Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=86086386765bc73084cc59076f65482d Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=86086386765bc73084cc59076f65482d in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=86086386765bc73084cc59076f65482d Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=3b23ca5b47502d5891d4aa7ebb18c1f1 Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=3b23ca5b47502d5891d4aa7ebb18c1f1 in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=3b23ca5b47502d5891d4aa7ebb18c1f1 Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=648088fd1ff0f5244d25ac69ca417222 Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=648088fd1ff0f5244d25ac69ca417222 in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=648088fd1ff0f5244d25ac69ca417222 Aug 28 14:11:42 volumio volumio[12883]: info: Adding Item to queue: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=40bcebae6eff6144ca718d24b0592014 Aug 28 14:11:42 volumio volumio[12883]: info: Exploding uri jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=40bcebae6eff6144ca718d24b0592014 in service jellyfin Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-browse] explodeUri: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/library@parentId=8a05b0252259a1dbd62df97522638439/songs@albumId=921f4e9528a7ad22c0ed8c92eed8e79a/song@songId=40bcebae6eff6144ca718d24b0592014 Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::stop Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::play index undefined Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::getTrack 2 Aug 28 14:11:42 volumio volumio[12883]: info: CoreStateMachine::startPlaybackTimer Aug 28 14:11:42 volumio volumio[12883]: info: CorePlayQueue::getTrack 2 Aug 28 14:11:42 volumio volumio[12883]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/lorebern@a0d6774c3d7f4d3caacc5a0d3cc186a9/song@songId=1fb6506fbeef71fefa5e97a62ab9b57d Aug 28 14:11:42 volumio volumio[12883]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:11:42 volumio volumio[12883]: Error: No media streams found for song 03-Lose My Way Aug 28 14:11:42 volumio volumio[12883]: at PlayController._PlayController_getStreamUrl (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:241:15) Aug 28 14:11:42 volumio volumio[12883]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:78:234) Aug 28 14:11:42 volumio volumio[12883]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Aug 28 14:11:42 volumio volumio[12883]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:11:42 volumio sudo[13318]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 14:10' Aug 28 14:11:42 volumio sudo[13318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"