-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-12-06 14:36:51 CET. -- Dec 06 14:35:02 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:35:02 onurekv volumio[3407]: info: Listing playlists Dec 06 14:35:02 onurekv volumio[3407]: info: Listing playlists Dec 06 14:35:03 onurekv volumio[3407]: info: VolumeController::SetAlsaVolume35 Dec 06 14:35:03 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:03 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:03 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:03 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:03 onurekv volumio[3407]: info: Dec 06 14:35:03 onurekv volumio[3407]: ---------------------------- MPD announces state update: mixer Dec 06 14:35:03 onurekv volumio[3407]: info: ControllerMpd::getState Dec 06 14:35:03 onurekv volumio[3407]: verbose: ControllerMpd::sendMpdCommand status Dec 06 14:35:03 onurekv volumio[3407]: info: sendMpdCommand status took 3 milliseconds Dec 06 14:35:03 onurekv volumio[3407]: verbose: ControllerMpd::parseState Dec 06 14:35:03 onurekv volumio[3407]: info: ControllerMpd::pushState Dec 06 14:35:03 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:03 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:03 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:03 onurekv volumio[3407]: info: CorePlayQueue::getTrack 0 Dec 06 14:35:03 onurekv volumio[3407]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 06 14:35:03 onurekv volumio[3407]: verbose: CURRENT POSITION 0 Dec 06 14:35:03 onurekv volumio[3407]: info: CoreStateMachine::syncState stateService stop Dec 06 14:35:03 onurekv volumio[3407]: info: CoreStateMachine::syncState currentStatus stop Dec 06 14:35:03 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:03 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:03 onurekv volumio[3407]: info: No code Dec 06 14:35:03 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:03 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:03 onurekv volumio[3407]: info: ------------------------------ 56ms Dec 06 14:35:03 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:03 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:03 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:12 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:21 onurekv shairport-sync[3623]: {"time":1765028054794,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 06 14:35:21 onurekv shairport-sync[3623]: Dload Upload Total Spent Left Speed Dec 06 14:35:21 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:21 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:21 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:21 onurekv volumio[3407]: info: Dec 06 14:35:21 onurekv volumio[3407]: ---------------------------- Client requests Stop Airplay Playback Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Dec 06 14:35:21 onurekv volumio[3407]: info: Airplay playback stop Dec 06 14:35:21 onurekv volumio[3407]: info: Airplay Playback Stopped, clearing state Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::resetVolumioState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::getcurrentVolume Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::volumioRetrievevolume Dec 06 14:35:21 onurekv shairport-sync[3623]: [237B blob data] Dec 06 14:35:21 onurekv volumio[3407]: info: VolumeController:: Volume=35 Mute =false Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::updateTrackBlock Dec 06 14:35:21 onurekv volumio[3407]: info: CorePlayQueue::getTrackBlock Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::volumioRetrievevolume Dec 06 14:35:21 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:21 onurekv volumio[3407]: info: VolumeController:: Volume=35 Mute =false Dec 06 14:35:21 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:21 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:21 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:22 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:35:22 onurekv volumio[3407]: info: Listing playlists Dec 06 14:35:22 onurekv volumio[3407]: info: Listing playlists Dec 06 14:35:24 onurekv volumio[3407]: info: Airplay started streaming, receiving metadatas Dec 06 14:35:24 onurekv volumio[3407]: info: Airplay started streaming, receiving metadatas Dec 06 14:35:24 onurekv volumio[3407]: info: Airplay started streaming, receiving metadatas Dec 06 14:35:24 onurekv shairport-sync[3623]: {"time":1765028121337,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 06 14:35:24 onurekv shairport-sync[3623]: Dload Upload Total Spent Left Speed Dec 06 14:35:24 onurekv volumio[3407]: info: Dec 06 14:35:24 onurekv volumio[3407]: ---------------------------- Client requests Start Airplay PlaybackRoutine Dec 06 14:35:24 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Dec 06 14:35:24 onurekv volumio[3407]: info: Airplay playback start Dec 06 14:35:24 onurekv shairport-sync[3623]: [158B blob data] Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:25 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:25 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:25 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:25 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:25 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:26 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:26 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:26 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:26 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:26 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:26 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:26 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:32 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:35:42 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:35:42 onurekv volumio[3407]: info: Listing playlists Dec 06 14:35:42 onurekv volumio[3407]: info: Listing playlists Dec 06 14:35:44 onurekv volumio[3407]: verbose: New Socket.io Connection to 192.168.1.117 from 192.168.1.189 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Dec 06 14:35:44 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:35:44 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 06 14:35:44 onurekv volumio[3407]: info: Listing playlists Dec 06 14:35:44 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetQueue Dec 06 14:35:44 onurekv volumio[3407]: info: CoreStateMachine::getQueue Dec 06 14:35:44 onurekv volumio[3407]: info: CorePlayQueue::getQueue Dec 06 14:35:44 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetVisibleSources Dec 06 14:35:44 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 06 14:35:46 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 06 14:35:46 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:48 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:48 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:48 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:48 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:48 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:48 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:48 onurekv volumio[3407]: info: [ASDebug] CurState: play PrevState: play Dec 06 14:35:49 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:49 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:49 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:49 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: play Dec 06 14:35:49 onurekv volumio[3407]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Dec 06 14:35:49 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: play Dec 06 14:35:49 onurekv volumio[3407]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Dec 06 14:35:49 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: play Dec 06 14:35:49 onurekv volumio[3407]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Dec 06 14:35:49 onurekv volumio[3407]: info: [ASDebug] Togle GPIO: OFF Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::servicePushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:50 onurekv shairport-sync[3623]: {"time":1765028124204,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 06 14:35:50 onurekv shairport-sync[3623]: Dload Upload Total Spent Left Speed Dec 06 14:35:50 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: pause Dec 06 14:35:50 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: pause Dec 06 14:35:50 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: pause Dec 06 14:35:50 onurekv volumio[3407]: info: Dec 06 14:35:50 onurekv volumio[3407]: ---------------------------- Client requests Stop Airplay Playback Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Dec 06 14:35:50 onurekv volumio[3407]: info: Airplay playback stop Dec 06 14:35:50 onurekv volumio[3407]: info: Airplay Playback Stopped, clearing state Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::resetVolumioState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::getcurrentVolume Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::volumioRetrievevolume Dec 06 14:35:50 onurekv shairport-sync[3623]: [158B blob data] Dec 06 14:35:50 onurekv volumio[3407]: info: VolumeController:: Volume=35 Mute =false Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::updateTrackBlock Dec 06 14:35:50 onurekv volumio[3407]: info: CorePlayQueue::getTrackBlock Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::volumioRetrievevolume Dec 06 14:35:50 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: pause Dec 06 14:35:50 onurekv volumio[3407]: info: VolumeController:: Volume=35 Mute =false Dec 06 14:35:50 onurekv volumio[3407]: info: CoreStateMachine::pushState Dec 06 14:35:50 onurekv volumio[3407]: info: CoreCommandRouter::volumioPushState Dec 06 14:35:50 onurekv volumio[3407]: info: [ASDebug] CurState: pause PrevState: pause Dec 06 14:35:52 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:36:02 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:36:02 onurekv volumio[3407]: info: Listing playlists Dec 06 14:36:02 onurekv volumio[3407]: info: Listing playlists Dec 06 14:36:09 onurekv volumio[3407]: info: Enabling plugin RoonBridge Dec 06 14:36:09 onurekv volumio[3407]: info: Loading plugin "RoonBridge"... Dec 06 14:36:09 onurekv volumio[3407]: info: PLUGIN START: RoonBridge Dec 06 14:36:09 onurekv sudo[4060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Dec 06 14:36:09 onurekv sudo[4060]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 06 14:36:09 onurekv sudo[4060]: pam_unix(sudo:session): session closed for user root Dec 06 14:36:09 onurekv volumio[3407]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Dec 06 14:36:09 onurekv volumio[3407]: Failed to start roonbridge.service: Unit roonbridge.service not found. Dec 06 14:36:09 onurekv volumio[3407]: info: Error: Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Dec 06 14:36:09 onurekv volumio[3407]: Failed to start roonbridge.service: Unit roonbridge.service not found. Dec 06 14:36:12 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:36:14 onurekv volumio[3407]: info: Starting Uninstall of plugin music_service - RoonBridge Dec 06 14:36:14 onurekv volumio[3407]: info: Uninstalling plugin RoonBridge Dec 06 14:36:14 onurekv sudo[4077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop roonbridge.service Dec 06 14:36:14 onurekv sudo[4077]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 06 14:36:14 onurekv sudo[4077]: pam_unix(sudo:session): session closed for user root Dec 06 14:36:14 onurekv volumio[3407]: error: Cannot kill Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl stop roonbridge.service Dec 06 14:36:14 onurekv volumio[3407]: Failed to stop roonbridge.service: Unit roonbridge.service not loaded. Dec 06 14:36:20 onurekv volumio[3407]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 14:36:20 onurekv volumio[3407]: info: [ASDebug] Setting UI defaults Dec 06 14:36:20 onurekv volumio[3407]: info: [ASDebug] Port: 24 Dec 06 14:36:20 onurekv volumio[3407]: info: [ASDebug] Inverted: false Dec 06 14:36:20 onurekv volumio[3407]: info: [ASDebug] Latched: false Dec 06 14:36:20 onurekv volumio[3407]: info: [ASDebug] On pulse width: 500 Dec 06 14:36:20 onurekv volumio[3407]: info: [ASDebug] Off pulse width: 500 Dec 06 14:36:22 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:36:22 onurekv volumio[3407]: info: Listing playlists Dec 06 14:36:22 onurekv volumio[3407]: info: Listing playlists Dec 06 14:36:32 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:36:32 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 06 14:36:32 onurekv volumio[3407]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 06 14:36:40 onurekv volumio[3407]: info: Starting Uninstall of plugin music_service - RoonBridge Dec 06 14:36:40 onurekv volumio[3407]: info: Uninstalling plugin RoonBridge Dec 06 14:36:41 onurekv sudo[4150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop roonbridge.service Dec 06 14:36:41 onurekv sudo[4150]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 06 14:36:41 onurekv sudo[4150]: pam_unix(sudo:session): session closed for user root Dec 06 14:36:41 onurekv volumio[3407]: error: Cannot kill Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl stop roonbridge.service Dec 06 14:36:41 onurekv volumio[3407]: Failed to stop roonbridge.service: Unit roonbridge.service not loaded. Dec 06 14:36:42 onurekv volumio[3407]: info: CoreCommandRouter::volumioGetState Dec 06 14:36:42 onurekv volumio[3407]: info: Listing playlists Dec 06 14:36:42 onurekv volumio[3407]: info: Listing playlists Dec 06 14:36:42 onurekv volumio[3407]: info: Enabling plugin RoonBridge Dec 06 14:36:42 onurekv volumio[3407]: info: Loading plugin "RoonBridge"... Dec 06 14:36:42 onurekv volumio[3407]: info: Applying required configuration parameters for plugin RoonBridge Dec 06 14:36:42 onurekv volumio[3407]: info: PLUGIN START: RoonBridge Dec 06 14:36:42 onurekv sudo[4167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Dec 06 14:36:42 onurekv sudo[4167]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 06 14:36:42 onurekv sudo[4167]: pam_unix(sudo:session): session closed for user root Dec 06 14:36:42 onurekv volumio[3407]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Dec 06 14:36:42 onurekv volumio[3407]: Failed to start roonbridge.service: Unit roonbridge.service not found. Dec 06 14:36:42 onurekv volumio[3407]: info: Error: Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Dec 06 14:36:42 onurekv volumio[3407]: Failed to start roonbridge.service: Unit roonbridge.service not found. Dec 06 14:36:46 onurekv volumio[3407]: info: [ASDebug] Port: 24 Dec 06 14:36:46 onurekv volumio[3407]: info: [ASDebug] Inverted: false Dec 06 14:36:46 onurekv volumio[3407]: info: [ASDebug] Delay: 720 Dec 06 14:36:50 onurekv volumio[3407]: info: Starting Uninstall of plugin system_controller - ampswitch Dec 06 14:36:50 onurekv volumio[3407]: info: Uninstalling plugin ampswitch Dec 06 14:36:50 onurekv volumio[3407]: info: [ASDebug] Port: 24 Dec 06 14:36:50 onurekv volumio[3407]: info: [ASDebug] Inverted: false Dec 06 14:36:50 onurekv volumio[3407]: info: [ASDebug] Delay: 720 Dec 06 14:36:50 onurekv volumio[3407]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 14:36:50 onurekv volumio[3407]: Error: EBADF: bad file descriptor, close Dec 06 14:36:50 onurekv volumio[3407]: at Object.closeSync (fs.js:439:3) Dec 06 14:36:50 onurekv volumio[3407]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Dec 06 14:36:50 onurekv volumio[3407]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) Dec 06 14:36:50 onurekv volumio[3407]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Dec 06 14:36:50 onurekv volumio[3407]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Dec 06 14:36:50 onurekv volumio[3407]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Dec 06 14:36:50 onurekv volumio[3407]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Dec 06 14:36:50 onurekv volumio[3407]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Dec 06 14:36:50 onurekv volumio[3407]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22) Dec 06 14:36:50 onurekv volumio[3407]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1271:45) Dec 06 14:36:50 onurekv volumio[3407]: at Socket.emit (events.js:315:20) Dec 06 14:36:50 onurekv volumio[3407]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 06 14:36:50 onurekv volumio[3407]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Dec 06 14:36:50 onurekv volumio[3407]: errno: -9, Dec 06 14:36:50 onurekv volumio[3407]: syscall: 'close', Dec 06 14:36:50 onurekv volumio[3407]: code: 'EBADF' Dec 06 14:36:50 onurekv volumio[3407]: } Dec 06 14:36:50 onurekv volumio[3407]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 14:36:51 onurekv sudo[4182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-06 14:35 Dec 06 14:36:51 onurekv sudo[4182]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"