-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2025-10-31 01:03:09 CET. -- Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: pause Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] Togle GPIO: ON Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:00 volumio volumio[834]: info: Updating volume from AirPlay: -29.18; 3% Oct 31 01:02:00 volumio volumio[834]: info: VolumeController::SetAlsaVolume3 Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:00 volumio volumio[834]: info: Updating volume from AirPlay: -28.88; 4% Oct 31 01:02:00 volumio volumio[834]: info: VolumeController::SetAlsaVolume4 Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:00 volumio volumio[834]: info: Updating volume from AirPlay: -28.27; 6% Oct 31 01:02:00 volumio volumio[834]: info: VolumeController::SetAlsaVolume6 Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:00 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:00 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:01 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:01 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:01 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:01 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:01 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:01 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:01 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:01 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:01 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:01 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:01 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:01 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:01 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:01 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:01 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:01 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:01 volumio volumio[834]: info: Updating volume from AirPlay: -28.58; 5% Oct 31 01:02:01 volumio volumio[834]: info: VolumeController::SetAlsaVolume5 Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:02 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:02 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:02 volumio volumio[834]: info: Updating volume from AirPlay: -28.88; 4% Oct 31 01:02:02 volumio volumio[834]: info: VolumeController::SetAlsaVolume4 Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:02 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:02 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:02 volumio volumio[834]: info: Updating volume from AirPlay: -29.21; 3% Oct 31 01:02:02 volumio volumio[834]: info: VolumeController::SetAlsaVolume3 Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:02 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:02 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:02 volumio volumio[834]: info: Updating volume from AirPlay: -29.51; 2% Oct 31 01:02:02 volumio volumio[834]: info: VolumeController::SetAlsaVolume2 Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:02 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:02 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:02 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:04 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: play Oct 31 01:02:04 volumio volumio[834]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Oct 31 01:02:05 volumio volumio[834]: info: [ASDebug] Togle GPIO: OFF Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:09 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: pause Oct 31 01:02:09 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: pause Oct 31 01:02:09 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: pause Oct 31 01:02:09 volumio shairport-sync[1181]: {"time":1761868919089,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Oct 31 01:02:09 volumio shairport-sync[1181]: Dload Upload Total Spent Left Speed Oct 31 01:02:09 volumio volumio[834]: info: Oct 31 01:02:09 volumio volumio[834]: ---------------------------- Client requests Stop Airplay Playback Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Oct 31 01:02:09 volumio volumio[834]: info: Airplay playback stop Oct 31 01:02:09 volumio volumio[834]: info: Airplay Playback Stopped, clearing state Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::resetVolumioState Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::getcurrentVolume Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioRetrievevolume Oct 31 01:02:09 volumio shairport-sync[1181]: [158B blob data] Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::updateTrackBlock Oct 31 01:02:09 volumio volumio[834]: info: CorePlayQueue::getTrackBlock Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioRetrievevolume Oct 31 01:02:09 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: pause Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:09 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:09 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:09 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: pause Oct 31 01:02:14 volumio volumio[834]: info: Airplay started streaming, receiving metadatas Oct 31 01:02:14 volumio volumio[834]: info: Airplay started streaming, receiving metadatas Oct 31 01:02:14 volumio volumio[834]: info: Airplay started streaming, receiving metadatas Oct 31 01:02:14 volumio shairport-sync[1181]: {"time":1761868929763,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Oct 31 01:02:14 volumio shairport-sync[1181]: Dload Upload Total Spent Left Speed Oct 31 01:02:14 volumio volumio[834]: info: Oct 31 01:02:14 volumio volumio[834]: ---------------------------- Client requests Start Airplay PlaybackRoutine Oct 31 01:02:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Oct 31 01:02:14 volumio volumio[834]: info: Airplay playback start Oct 31 01:02:14 volumio shairport-sync[1181]: [158B blob data] Oct 31 01:02:14 volumio volumio[834]: info: Updating volume from AirPlay: -20; 33% Oct 31 01:02:14 volumio volumio[834]: info: VolumeController::SetAlsaVolume33 Oct 31 01:02:14 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:14 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:14 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:14 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: pause Oct 31 01:02:14 volumio volumio[834]: info: [ASDebug] Togle GPIO: ON Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:15 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:15 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:15 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:15 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:15 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:15 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:15 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:15 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:15 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:16 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:16 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:16 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:16 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:16 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:02:16 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:02:16 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: play Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: play Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: play Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] CurState: pause PrevState: play Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Oct 31 01:02:16 volumio volumio[834]: info: [ASDebug] Togle GPIO: OFF Oct 31 01:02:24 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:27 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:02:27 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 31 01:02:31 volumio volumio[834]: info: [ASDebug] Port: 12 Oct 31 01:02:31 volumio volumio[834]: info: [ASDebug] Inverted: false Oct 31 01:02:31 volumio volumio[834]: info: [ASDebug] Delay: 720 Oct 31 01:02:39 volumio volumio[834]: info: Enabling plugin gpio_control Oct 31 01:02:39 volumio volumio[834]: info: Loading plugin "gpio_control"... Oct 31 01:02:39 volumio volumio[834]: gpiox_arm32 V2.1.0 Oct 31 01:02:39 volumio volumio[834]: info: Applying required configuration parameters for plugin gpio_control Oct 31 01:02:39 volumio volumio[834]: info: PLUGIN START: gpio_control Oct 31 01:02:39 volumio volumio[834]: info: [GPIO_Control] Reading config and creating GPIOs Oct 31 01:02:39 volumio volumio[834]: info: [GPIO_Control] GPIOs created Oct 31 01:02:39 volumio volumio[834]: info: [GPIO_Control] Handling event: systemStartup Oct 31 01:02:39 volumio volumio[834]: info: Done. Oct 31 01:02:39 volumio volumio[834]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 31 01:02:39 volumio volumio[834]: info: CoreCommandRouter::volumioGetState Oct 31 01:02:42 volumio volumio[834]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 01:02:42 volumio volumio[834]: info: [ASDebug] Setting UI defaults Oct 31 01:02:42 volumio volumio[834]: info: [ASDebug] Port: 12 Oct 31 01:02:42 volumio volumio[834]: info: [ASDebug] Inverted: false Oct 31 01:02:42 volumio volumio[834]: info: [ASDebug] Latched: false Oct 31 01:02:42 volumio volumio[834]: info: [ASDebug] On pulse width: 500 Oct 31 01:02:42 volumio volumio[834]: info: [ASDebug] Off pulse width: 500 Oct 31 01:02:50 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:02:50 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 31 01:02:54 volumio volumio[834]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 01:03:07 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:03:07 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Oct 31 01:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Oct 31 01:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Oct 31 01:03:08 volumio volumio[834]: info: [ASDebug] CurState: play PrevState: pause Oct 31 01:03:08 volumio volumio[834]: info: [ASDebug] Togle GPIO: ON Oct 31 01:03:08 volumio volumio[834]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 01:03:08 volumio volumio[834]: Error: ESPIPE: invalid seek, write Oct 31 01:03:08 volumio volumio[834]: at Object.writeSync (fs.js:711:3) Oct 31 01:03:08 volumio volumio[834]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Oct 31 01:03:08 volumio volumio[834]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:207:23) Oct 31 01:03:08 volumio volumio[834]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:190:86) Oct 31 01:03:08 volumio volumio[834]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Oct 31 01:03:08 volumio volumio[834]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10) Oct 31 01:03:08 volumio volumio[834]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12) Oct 31 01:03:08 volumio volumio[834]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Oct 31 01:03:08 volumio volumio[834]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Oct 31 01:03:08 volumio volumio[834]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8) Oct 31 01:03:08 volumio volumio[834]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Oct 31 01:03:08 volumio volumio[834]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Oct 31 01:03:08 volumio volumio[834]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:254:12) Oct 31 01:03:08 volumio volumio[834]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16) Oct 31 01:03:08 volumio volumio[834]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Oct 31 01:03:08 volumio volumio[834]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) { Oct 31 01:03:08 volumio volumio[834]: errno: -29, Oct 31 01:03:08 volumio volumio[834]: syscall: 'write', Oct 31 01:03:08 volumio volumio[834]: code: 'ESPIPE' Oct 31 01:03:08 volumio volumio[834]: } Oct 31 01:03:08 volumio volumio[834]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 01:03:09 volumio sudo[2366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-31 01:02 Oct 31 01:03:09 volumio sudo[2366]: 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="5d50cd80bebce60dddccd7f5e813d656e28ca4cd" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="7840f283c310c38bfe939a4c485727a6ff6a0ce1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 21 Oct 2025 03:46:47 PM CEST" VOLUMIO_VERSION="3.866" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e2f3a8aca3147ba51b5da8167dd6ff8"