-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Mon 2026-08-31 16:26:41 CST. -- Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:03 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:09 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:10 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:16 volumio shairport-sync[12066]: {"time":1788164691581,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Aug 31 16:25:16 volumio shairport-sync[12066]: Dload Upload Total Spent Left Speed Aug 31 16:25:16 volumio volumio[11911]: info: Aug 31 16:25:16 volumio volumio[11911]: ---------------------------- Client requests Stop Airplay Playback Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Aug 31 16:25:16 volumio volumio[11911]: info: Airplay playback stop Aug 31 16:25:16 volumio volumio[11911]: info: Airplay Playback Stopped, clearing state Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::resetVolumioState Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::getcurrentVolume Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 16:25:16 volumio shairport-sync[12066]: [158B blob data] Aug 31 16:25:16 volumio volumio[11911]: info: VolumeController:: Volume=100 Mute =false Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::updateTrackBlock Aug 31 16:25:16 volumio volumio[11911]: info: CorePlayQueue::getTrackBlock Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 16:25:16 volumio volumio[11911]: info: VolumeController:: Volume=100 Mute =false Aug 31 16:25:16 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:16 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:18 volumio volumio[11911]: info: Airplay started streaming, receiving metadatas Aug 31 16:25:18 volumio volumio[11911]: info: Airplay started streaming, receiving metadatas Aug 31 16:25:18 volumio shairport-sync[12066]: {"time":1788164716175,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Aug 31 16:25:18 volumio shairport-sync[12066]: Dload Upload Total Spent Left Speed Aug 31 16:25:18 volumio volumio[11911]: info: Aug 31 16:25:18 volumio volumio[11911]: ---------------------------- Client requests Start Airplay PlaybackRoutine Aug 31 16:25:18 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Aug 31 16:25:18 volumio volumio[11911]: info: Airplay playback start Aug 31 16:25:18 volumio shairport-sync[12066]: [158B blob data] Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:19 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:20 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:25 volumio shairport-sync[12066]: {"time":1788164718313,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Aug 31 16:25:25 volumio shairport-sync[12066]: Dload Upload Total Spent Left Speed Aug 31 16:25:25 volumio volumio[11911]: info: Aug 31 16:25:25 volumio volumio[11911]: ---------------------------- Client requests Stop Airplay Playback Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Aug 31 16:25:25 volumio volumio[11911]: info: Airplay playback stop Aug 31 16:25:25 volumio volumio[11911]: info: Airplay Playback Stopped, clearing state Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::resetVolumioState Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::getcurrentVolume Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 16:25:25 volumio shairport-sync[12066]: [158B blob data] Aug 31 16:25:25 volumio volumio[11911]: info: VolumeController:: Volume=100 Mute =false Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::updateTrackBlock Aug 31 16:25:25 volumio volumio[11911]: info: CorePlayQueue::getTrackBlock Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 16:25:25 volumio volumio[11911]: info: VolumeController:: Volume=100 Mute =false Aug 31 16:25:25 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:25 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:27 volumio volumio[11911]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Aug 31 16:25:27 volumio volumio[11911]: info: Retrying Login Due to Network Error Aug 31 16:25:31 volumio volumio[11911]: info: Airplay started streaming, receiving metadatas Aug 31 16:25:31 volumio volumio[11911]: info: Airplay started streaming, receiving metadatas Aug 31 16:25:31 volumio shairport-sync[12066]: {"time":1788164725573,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Aug 31 16:25:31 volumio shairport-sync[12066]: Dload Upload Total Spent Left Speed Aug 31 16:25:31 volumio volumio[11911]: info: Aug 31 16:25:31 volumio volumio[11911]: ---------------------------- Client requests Start Airplay PlaybackRoutine Aug 31 16:25:31 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Aug 31 16:25:31 volumio volumio[11911]: info: Airplay playback start Aug 31 16:25:31 volumio shairport-sync[12066]: [158B blob data] Aug 31 16:25:31 volumio volumio[11911]: info: Updating volume from AirPlay: -20; 33% Aug 31 16:25:31 volumio volumio[11911]: info: VolumeController::SetAlsaVolume33 Aug 31 16:25:31 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:31 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:31 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:32 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:33 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:34 volumio volumio[11911]: info: Updating volume from AirPlay: -18.12; 40% Aug 31 16:25:34 volumio volumio[11911]: info: VolumeController::SetAlsaVolume40 Aug 31 16:25:34 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:34 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:34 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:35 volumio volumio[11911]: info: Updating volume from AirPlay: -16.25; 46% Aug 31 16:25:35 volumio volumio[11911]: info: VolumeController::SetAlsaVolume46 Aug 31 16:25:35 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:35 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:35 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:37 volumio volumio[11911]: info: MyVolumio login type: Token Aug 31 16:25:40 volumio volumio[11911]: info: Updating volume from AirPlay: -14.37; 52% Aug 31 16:25:40 volumio volumio[11911]: info: VolumeController::SetAlsaVolume52 Aug 31 16:25:40 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:40 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:40 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:40 volumio volumio[11911]: info: Updating volume from AirPlay: -12.5; 58% Aug 31 16:25:40 volumio volumio[11911]: info: VolumeController::SetAlsaVolume58 Aug 31 16:25:40 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:40 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:40 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:49 volumio shairport-sync[12066]: {"time":1788164731185,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Aug 31 16:25:49 volumio shairport-sync[12066]: Dload Upload Total Spent Left Speed Aug 31 16:25:49 volumio volumio[11911]: info: Aug 31 16:25:49 volumio volumio[11911]: ---------------------------- Client requests Stop Airplay Playback Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Aug 31 16:25:49 volumio volumio[11911]: info: Airplay playback stop Aug 31 16:25:49 volumio volumio[11911]: info: Airplay Playback Stopped, clearing state Aug 31 16:25:49 volumio volumio[11911]: info: CoreStateMachine::resetVolumioState Aug 31 16:25:49 volumio volumio[11911]: info: CoreStateMachine::getcurrentVolume Aug 31 16:25:49 volumio volumio[11911]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 16:25:49 volumio shairport-sync[12066]: [158B blob data] Aug 31 16:25:50 volumio volumio[11911]: info: VolumeController:: Volume=57 Mute =false Aug 31 16:25:50 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:50 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:25:50 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:50 volumio volumio[11911]: info: CoreStateMachine::updateTrackBlock Aug 31 16:25:50 volumio volumio[11911]: info: CorePlayQueue::getTrackBlock Aug 31 16:25:50 volumio volumio[11911]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 16:25:50 volumio volumio[11911]: info: VolumeController:: Volume=57 Mute =false Aug 31 16:25:50 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:25:50 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:25:59 volumio volumio[11911]: info: Airplay started streaming, receiving metadatas Aug 31 16:25:59 volumio volumio[11911]: info: Airplay started streaming, receiving metadatas Aug 31 16:25:59 volumio shairport-sync[12066]: {"time":1788164749951,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Aug 31 16:25:59 volumio shairport-sync[12066]: Dload Upload Total Spent Left Speed Aug 31 16:25:59 volumio volumio[11911]: info: Aug 31 16:25:59 volumio volumio[11911]: ---------------------------- Client requests Start Airplay PlaybackRoutine Aug 31 16:25:59 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Aug 31 16:25:59 volumio volumio[11911]: info: Airplay playback start Aug 31 16:25:59 volumio shairport-sync[12066]: [158B blob data] Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:00 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:01 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:05 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::servicePushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:06 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:07 volumio volumio[11911]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Aug 31 16:26:07 volumio volumio[11911]: info: Retrying Login Due to Network Error Aug 31 16:26:15 volumio volumio[11911]: info: Updating volume from AirPlay: -10.62; 65% Aug 31 16:26:15 volumio volumio[11911]: info: VolumeController::SetAlsaVolume65 Aug 31 16:26:15 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:15 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:15 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:16 volumio volumio[11911]: info: Updating volume from AirPlay: -8.75; 71% Aug 31 16:26:16 volumio volumio[11911]: info: VolumeController::SetAlsaVolume71 Aug 31 16:26:16 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:16 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:16 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:17 volumio volumio[11911]: info: MyVolumio login type: Token Aug 31 16:26:22 volumio volumio[11911]: info: Updating volume from AirPlay: -6.87; 77% Aug 31 16:26:22 volumio volumio[11911]: info: VolumeController::SetAlsaVolume77 Aug 31 16:26:22 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:22 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:22 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:29 volumio volumio[11911]: info: Updating volume from AirPlay: -5; 83% Aug 31 16:26:29 volumio volumio[11911]: info: VolumeController::SetAlsaVolume83 Aug 31 16:26:29 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:29 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:29 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:29 volumio volumio[11911]: info: Updating volume from AirPlay: -3.12; 90% Aug 31 16:26:29 volumio volumio[11911]: info: VolumeController::SetAlsaVolume90 Aug 31 16:26:29 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:29 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:29 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:29 volumio volumio[11911]: info: Updating volume from AirPlay: 0; 100% Aug 31 16:26:29 volumio volumio[11911]: info: VolumeController::SetAlsaVolume100 Aug 31 16:26:29 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:29 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:29 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:32 volumio volumio[11911]: info: Updating volume from AirPlay: -1.88; 94% Aug 31 16:26:32 volumio volumio[11911]: info: VolumeController::SetAlsaVolume94 Aug 31 16:26:32 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:32 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:32 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:33 volumio volumio[11911]: info: Updating volume from AirPlay: -3.75; 88% Aug 31 16:26:33 volumio volumio[11911]: info: VolumeController::SetAlsaVolume88 Aug 31 16:26:33 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:33 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:33 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:37 volumio volumio[11911]: info: Updating volume from AirPlay: -1.88; 94% Aug 31 16:26:37 volumio volumio[11911]: info: VolumeController::SetAlsaVolume94 Aug 31 16:26:37 volumio volumio[11911]: info: CoreStateMachine::pushState Aug 31 16:26:37 volumio volumio[11911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 16:26:37 volumio volumio[11911]: info: CoreCommandRouter::volumioPushState Aug 31 16:26:40 volumio volumio[11911]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 16:26:40 volumio volumio[11911]: Error: connect ETIMEDOUT 128.242.240.253:443 Aug 31 16:26:40 volumio volumio[11911]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 31 16:26:40 volumio volumio[11911]: errno: -110, Aug 31 16:26:40 volumio volumio[11911]: code: 'ETIMEDOUT', Aug 31 16:26:40 volumio volumio[11911]: syscall: 'connect', Aug 31 16:26:40 volumio volumio[11911]: address: '128.242.240.253', Aug 31 16:26:40 volumio volumio[11911]: port: 443 Aug 31 16:26:40 volumio volumio[11911]: } Aug 31 16:26:40 volumio volumio[11911]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 16:26:41 volumio sudo[12815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-31 16:25 Aug 31 16:26:41 volumio sudo[12815]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 09:58:18 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="54b3518c7dd8feba4753e0ad124ce801"