Feb 23 13:42:00 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:00 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:00 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:00 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:00 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:00 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:00 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:00 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:00 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:00 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:00 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:00 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:01 volumio volumio[1260]: info: Updating volume from AirPlay: -18.38; 39% Feb 23 13:42:01 volumio volumio[1260]: info: VolumeController::SetAlsaVolume39 Feb 23 13:42:01 volumio volumio[1260]: info: [squeezelite_mc] Setting Squeezelite volume to 39 Feb 23 13:42:01 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:01 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:01 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:01 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:01 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:01 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:01 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:01 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:02 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:02 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 23 13:42:02 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:03 volumio volumio[1260]: info: Updating volume from AirPlay: -20.25; 33% Feb 23 13:42:03 volumio volumio[1260]: info: VolumeController::SetAlsaVolume33 Feb 23 13:42:03 volumio volumio[1260]: info: [squeezelite_mc] Setting Squeezelite volume to 33 Feb 23 13:42:03 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:03 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:03 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:03 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:05 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:05 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:05 volumio shairport-sync[3234]: {"time":1771854117973,"response":"startAirplayPlayback Success"} Feb 23 13:42:05 volumio shairport-sync[3314]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 23 13:42:05 volumio shairport-sync[3314]: Dload Upload Total Spent Left Speed Feb 23 13:42:05 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:06 volumio volumio[1260]: info: Feb 23 13:42:06 volumio volumio[1260]: ---------------------------- Client requests Stop Airplay Playback Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Feb 23 13:42:06 volumio volumio[1260]: info: Airplay playback stop Feb 23 13:42:06 volumio volumio[1260]: info: Airplay Playback Stopped, clearing state Feb 23 13:42:06 volumio volumio[1260]: info: CoreStateMachine::resetVolumioState Feb 23 13:42:06 volumio volumio[1260]: info: CoreStateMachine::getcurrentVolume Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 13:42:06 volumio shairport-sync[3314]: [158B blob data] Feb 23 13:42:06 volumio volumio[1260]: info: VolumeController:: Volume=33 Mute =false Feb 23 13:42:06 volumio volumio[1260]: info: [squeezelite_mc] Setting Squeezelite volume to 33 Feb 23 13:42:06 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:06 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:06 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:06 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Feb 23 13:42:06 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:06 volumio volumio[1260]: info: VolumeController:: Volume=33 Mute =false Feb 23 13:42:06 volumio volumio[1260]: info: [squeezelite_mc] Setting Squeezelite volume to 33 Feb 23 13:42:06 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:06 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:06 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:06 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:06 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:15 volumio shairport-sync[3314]: {"time":1771854126074,"response":"stopAirplayPlayback Success"} Feb 23 13:42:15 volumio shairport-sync[3357]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 23 13:42:15 volumio shairport-sync[3357]: Dload Upload Total Spent Left Speed Feb 23 13:42:15 volumio volumio[1260]: info: Feb 23 13:42:15 volumio volumio[1260]: ---------------------------- Client requests AirplayInactive Feb 23 13:42:15 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayInctive Feb 23 13:42:15 volumio shairport-sync[3357]: [158B blob data] Feb 23 13:42:20 volumio squeezeboxserver[2111]: [13:42:20.629] output_flush:331 [0xdbb748]: flush output buffer (full) Feb 23 13:42:20 volumio squeezeboxserver[2111]: [13:42:20.629] PlayerThread:582 [0xe0e1b0]: flushing ... Feb 23 13:42:20 volumio squeezeboxserver[2111]: [13:42:20.641] output_flush:331 [0xdbe550]: flush output buffer (full) Feb 23 13:42:20 volumio squeezeboxserver[2111]: [13:42:20.642] PlayerThread:582 [0xe0f0a0]: flushing ... Feb 23 13:42:20 volumio squeezeboxserver[2111]: [13:42:20.697] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.0.100:7000 Feb 23 13:42:20 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:21 volumio squeezeboxserver[2111]: [13:42:21.629] PlayerThread:481 [0xe0e1b0]: Disconnecting 2327615677 Feb 23 13:42:21 volumio squeezeboxserver[2111]: [13:42:21.642] PlayerThread:481 [0xe0f0a0]: Disconnecting 2327615690 Feb 23 13:42:22 volumio squeezeboxserver[2111]: [13:42:22.112] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.10.111:7000 Feb 23 13:42:22 volumio squeezeboxserver[2111]: [13:42:22.127] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.0.100:7000 Feb 23 13:42:25 volumio squeezeboxserver[2111]: [13:42:25.783] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.10.111:7000 Feb 23 13:42:28 volumio volumio[1260]: info: Airplay started streaming, receiving metadatas Feb 23 13:42:28 volumio volumio[1260]: info: Airplay started streaming, receiving metadatas Feb 23 13:42:28 volumio volumio[1260]: info: Airplay started streaming, receiving metadatas Feb 23 13:42:28 volumio volumio[1260]: info: Airplay started streaming, receiving metadatas Feb 23 13:42:28 volumio shairport-sync[3357]: {"time":1771854135970,"response":"airplayInactive Success"} Feb 23 13:42:28 volumio shairport-sync[3395]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 23 13:42:28 volumio shairport-sync[3395]: Dload Upload Total Spent Left Speed Feb 23 13:42:28 volumio volumio[1260]: info: Feb 23 13:42:28 volumio volumio[1260]: ---------------------------- Client requests AirplayActive Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Feb 23 13:42:28 volumio shairport-sync[3395]: [158B blob data] Feb 23 13:42:28 volumio shairport-sync[3395]: {"time":1771854148496,"response":"airplayActive Success"} Feb 23 13:42:28 volumio shairport-sync[3396]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 23 13:42:28 volumio shairport-sync[3396]: Dload Upload Total Spent Left Speed Feb 23 13:42:28 volumio shairport-sync[3396]: [158B blob data] Feb 23 13:42:28 volumio volumio[1260]: info: Feb 23 13:42:28 volumio volumio[1260]: ---------------------------- Client requests Start Airplay PlaybackRoutine Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Feb 23 13:42:28 volumio volumio[1260]: info: Airplay playback start Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:28 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:28 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:28 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio squeezeboxserver[2111]: [13:42:29.259] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.0.100:7000 Feb 23 13:42:29 volumio squeezeboxserver[2111]: [13:42:29.453] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.10.111:7000 Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:29 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:29 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:29 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:30 volumio volumio[1260]: info: Updating volume from AirPlay: -18.38; 39% Feb 23 13:42:30 volumio volumio[1260]: info: VolumeController::SetAlsaVolume39 Feb 23 13:42:30 volumio volumio[1260]: info: [squeezelite_mc] Setting Squeezelite volume to 39 Feb 23 13:42:30 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:30 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:30 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:30 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:30 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:30 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:30 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:30 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:30 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:30 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:30 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:30 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:30 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:30 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:30 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:30 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:31 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:31 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:31 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:31 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:31 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:42:31 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:42:33 volumio squeezeboxserver[2111]: [13:42:33.350] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.0.100:7000 Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:33 volumio squeezeboxserver[2111]: [13:42:33.646] mDNSsearchCallback:688 [0xe0b4e0]: changed ip:port 10.33.10.111:7000 Feb 23 13:42:33 volumio shairport-sync[3396]: {"time":1771854148505,"response":"startAirplayPlayback Success"} Feb 23 13:42:33 volumio shairport-sync[3472]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 23 13:42:33 volumio shairport-sync[3472]: Dload Upload Total Spent Left Speed Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:33 volumio volumio[1260]: info: Feb 23 13:42:33 volumio volumio[1260]: ---------------------------- Client requests Stop Airplay Playback Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Feb 23 13:42:33 volumio volumio[1260]: info: Airplay playback stop Feb 23 13:42:33 volumio volumio[1260]: info: Airplay Playback Stopped, clearing state Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::resetVolumioState Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::getcurrentVolume Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 13:42:33 volumio shairport-sync[3472]: [158B blob data] Feb 23 13:42:33 volumio volumio[1260]: info: VolumeController:: Volume=39 Mute =false Feb 23 13:42:33 volumio volumio[1260]: info: [squeezelite_mc] Setting Squeezelite volume to 39 Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Feb 23 13:42:33 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:33 volumio volumio[1260]: info: VolumeController:: Volume=39 Mute =false Feb 23 13:42:33 volumio volumio[1260]: info: [squeezelite_mc] Setting Squeezelite volume to 39 Feb 23 13:42:33 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:33 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:33 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:42:33 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:42:34 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:36 volumio kernel: CE: hpet increased min_delta_ns to 11521 nsec Feb 23 13:42:38 volumio volumio[1260]: info: CoreCommandRouter::volumioGetQueue Feb 23 13:42:38 volumio volumio[1260]: info: CoreStateMachine::getQueue Feb 23 13:42:38 volumio volumio[1260]: info: CorePlayQueue::getQueue Feb 23 13:42:40 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 23 13:42:43 volumio shairport-sync[3472]: {"time":1771854153733,"response":"stopAirplayPlayback Success"} Feb 23 13:42:43 volumio shairport-sync[3514]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 23 13:42:43 volumio shairport-sync[3514]: Dload Upload Total Spent Left Speed Feb 23 13:42:43 volumio volumio[1260]: info: Feb 23 13:42:43 volumio volumio[1260]: ---------------------------- Client requests AirplayInactive Feb 23 13:42:43 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayInctive Feb 23 13:42:43 volumio shairport-sync[3514]: [158B blob data] Feb 23 13:42:45 volumio volumio[1260]: info: Display-configuration --- → Sleep (DPMS) triggered after 120s Feb 23 13:42:45 volumio volumio[1260]: info: Display-configuration --- sleepScreen: DPMS - screen off in 120s Feb 23 13:42:47 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 23 13:42:48 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:48 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:50 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::ClearQueue Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::serviceStop Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::serviceStop Feb 23 13:42:50 volumio volumio[1260]: info: Airplay Stop Feb 23 13:42:50 volumio volumio[1260]: info: Stopping Airplay Playback and sending pause command to client via USR2 Feb 23 13:42:50 volumio volumio[1260]: info: CorePlayQueue::clearPlayQueue Feb 23 13:42:50 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::addQueueItems Feb 23 13:42:50 volumio volumio[1260]: info: CorePlayQueue::addQueueItems Feb 23 13:42:50 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:50 volumio volumio[1260]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:50 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Feb 23 13:42:50 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Feb 23 13:42:50 volumio volumio[1260]: verbose: UNSET VOLATILE: Service: airplay_emulation Feb 23 13:42:50 volumio volumio[1260]: info: Stopping Airplay Playback and sending pause command to client via USR2 Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::play index 0 Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::play index undefined Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:50 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:50 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer Feb 23 13:42:50 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:50 volumio sudo[3526]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 2334 Feb 23 13:42:50 volumio sudo[3526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 13:42:50 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 23 13:42:50 volumio volumio[1260]: info: [1771854170152] ControllerWebradio::clearAddPlayTrack Feb 23 13:42:50 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 13:42:50 volumio volumio[1260]: info: sendMpdCommand stop took 4 milliseconds Feb 23 13:42:50 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 13:42:50 volumio sudo[3526]: pam_unix(sudo:session): session closed for user root Feb 23 13:42:50 volumio volumio[1260]: info: Feb 23 13:42:50 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:42:50 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:42:50 volumio volumio[1260]: info: sendMpdCommand clear took 3 milliseconds Feb 23 13:42:50 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Feb 23 13:42:50 volumio shairport-sync[3514]: {"time":1771854163652,"response":"airplayInactive Success"} Feb 23 13:42:50 volumio volumio[1260]: error: updateQueue error: null Feb 23 13:42:50 volumio volumio[1260]: info: ------------------------------ 5ms Feb 23 13:42:50 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=12/USR2 Feb 23 13:42:50 volumio systemd[1]: shairport-sync.service: Failed with result 'signal'. Feb 23 13:42:50 volumio systemd[1]: shairport-sync.service: Consumed 2.715s CPU time. Feb 23 13:42:50 volumio volumio[1260]: info: Shairport-Sync paused with USR2 Feb 23 13:42:50 volumio sudo[3531]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 Feb 23 13:42:50 volumio sudo[3531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 13:42:50 volumio sudo[3531]: pam_unix(sudo:session): session closed for user root Feb 23 13:42:50 volumio volumio[1260]: info: Cannot execute Shairport-sync USR2 kill: Error: Command failed: /usr/bin/sudo /bin/kill -USR2 $(pidof shairport-sync) Feb 23 13:42:50 volumio volumio[1260]: Usage: Feb 23 13:42:50 volumio volumio[1260]: kill [options] [...] Feb 23 13:42:50 volumio volumio[1260]: Options: Feb 23 13:42:50 volumio volumio[1260]: [...] send signal to every listed Feb 23 13:42:50 volumio volumio[1260]: -, -s, --signal Feb 23 13:42:50 volumio volumio[1260]: specify the to be sent Feb 23 13:42:50 volumio volumio[1260]: -q, --queue integer value to be sent with the signal Feb 23 13:42:50 volumio volumio[1260]: -l, --list=[] list all signal names, or convert one to a name Feb 23 13:42:50 volumio volumio[1260]: -L, --table list all signal names in a nice table Feb 23 13:42:50 volumio volumio[1260]: -h, --help display this help and exit Feb 23 13:42:50 volumio volumio[1260]: -V, --version output version information and exit Feb 23 13:42:50 volumio volumio[1260]: For more details see kill(1). Feb 23 13:42:51 volumio volumio[1260]: info: Restarting Shairport-Sync after stop Feb 23 13:42:51 volumio sudo[3536]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 13:42:51 volumio sudo[3536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 13:42:51 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 23 13:42:51 volumio sudo[3536]: pam_unix(sudo:session): session closed for user root Feb 23 13:42:51 volumio volumio[1260]: info: Shairport-Sync retarted Feb 23 13:42:51 volumio shairport-sync[3538]: Can not set realtime properties of a thread. Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.022] AddRaopDevice:862 [0xe0a5f0]: AirPort Express Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.022] AddRaopDevice:912 [0xe0a5f0]: creating MAC Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.022] AddRaopDevice:926 [0xe0a5f0]: adding renderer (volumio@127.0.0.1) with mac AAAA-8D5EAC91 Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.022] raopcl_create:717 [0x7fa74407b7a0]: using PCM coding Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.022] output_raop_thread_init:119 [0xdaff28]: init output raop Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.022] output_init_common:290 allocating 1764000 Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.023] mDNSsearchCallback:743 Updating configuration /var/lib/squeezeboxserver/prefs/raopbridge.xml Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.023] mDNSsearchCallback:688 [0xe0a5f0]: changed ip:port 10.33.20.114:7000 Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.024] slimproto:834 squeezelite [0xdaff28] <=> player [0xe0a5f0] Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.024] slimproto:835 [0xdaff28] connecting to 10.33.20.114:3483 Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.025] slimproto:865 [0xdaff28] connected Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.025] sendHELO:107 [0xdaff28] cap: CanHTTPS=1,Model=squeezelite,ModelName=RaopBridge,AccuratePlayPoints=0,HasDigitalOut=1,MaxSampleRate=96000,aac,ogg,ops,ogf,flc,alc,wav,aif,pcm,mp3 Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.027] output_flush:331 [0xdaff28]: flush output buffer (full) Feb 23 13:42:52 volumio squeezeboxserver[2111]: [13:42:52.028] PlayerThread:595 [0xe0a5f0]: processing volume device:49 request:-15.31 Feb 23 13:42:52 volumio volumio[1260]: info: [squeezelite_mc] 'client' notification received from volumio (10.33.20.114); type is 'connect' Feb 23 13:42:52 volumio volumio[1260]: info: [squeezelite_mc] Getting players connected to volumio (10.33.20.114) Feb 23 13:42:52 volumio volumio[1260]: info: [squeezelite_mc] Players connected to volumio (10.33.20.114): [{"id":"aa:aa:42:33:7f:73","uuid":null,"ip":"10.33.20.114","name":"TX4GFQCYPP","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:8d:92:3c:4a","uuid":null,"ip":"10.33.20.114","name":"chufang","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:e1:16:e6:3f","uuid":null,"ip":"10.33.20.114","name":"woshi","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:b7:ec:35:1a","uuid":null,"ip":"10.33.20.114","name":"kakubou","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:91:ac:5e:8d","uuid":null,"ip":"10.33.20.114","name":"volumio","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:72:86:68:60","uuid":null,"ip":"10.33.20.114","name":"fuseshitsukara2","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:e1:12:8b:bf","uuid":null,"ip":"10.33.20.114","name":"keting","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"90:27:e4:ff:c7:ca","uuid":null,"ip":"10.33.20.114","name":"volumio","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:11:84:3e:29","uuid":null,"ip":"10.33.20.114","name":"kyakuchoukara2","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}},{"id":"aa:aa:c0:85:c4:3c","uuid":null,"ip":"10.33.20.114","name":"kyakuchoukara3","server":{"ip":"10.33.20.114","name":"volumio","ver":"9.1.0","uuid":"19bacaad-4245-4fa9-a2d6-7de4cc8ef381","jsonPort":"9000","cliPort":"9090"}}] Feb 23 13:42:52 volumio volumio[1260]: info: Display-configuration --- → Sleep (DPMS) triggered after 120s Feb 23 13:42:52 volumio volumio[1260]: info: Display-configuration --- → Sleep (DPMS) triggered after 120s Feb 23 13:42:52 volumio volumio[1260]: info: Display-configuration --- sleepScreen: DPMS - screen off in 120s Feb 23 13:42:52 volumio volumio[1260]: info: Display-configuration --- sleepScreen: DPMS - screen off in 120s Feb 23 13:42:52 volumio volumio[1260]: info: Display-configuration --- → Sleep (DPMS) triggered after 120s Feb 23 13:42:52 volumio volumio[1260]: info: Display-configuration --- sleepScreen: DPMS - screen off in 120s Feb 23 13:42:53 volumio volumio[1260]: info: Display-configuration --- → Sleep (DPMS) triggered after 120s Feb 23 13:42:53 volumio volumio[1260]: info: Display-configuration --- sleepScreen: DPMS - screen off in 120s Feb 23 13:42:53 volumio squeezeboxserver[2111]: [13:42:53.044] mDNSsearchCallback:688 [0xe0a5f0]: changed ip:port 127.0.0.1:7000 Feb 23 13:42:53 volumio squeezeboxserver[2111]: [13:42:53.044] mDNSsearchCallback:688 [0xe0a5f0]: changed ip:port 10.33.20.114:7000 Feb 23 13:42:53 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::ClearQueue Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::clearPlayQueue Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::addQueueItems Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::addQueueItems Feb 23 13:42:53 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:53 volumio volumio[1260]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::play index 0 Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::play index undefined Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:53 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer Feb 23 13:42:53 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 13:42:53 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 23 13:42:53 volumio volumio[1260]: info: [1771854173078] ControllerWebradio::clearAddPlayTrack Feb 23 13:42:53 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 13:42:55 volumio squeezeboxserver[2111]: [13:42:55.067] mDNSsearchCallback:688 [0xe0a5f0]: changed ip:port 127.0.0.1:7000 Feb 23 13:42:55 volumio squeezeboxserver[2111]: [13:42:55.068] mDNSsearchCallback:688 [0xe0a5f0]: changed ip:port 10.33.20.114:7000 Feb 23 13:42:55 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::ClearQueue Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::clearPlayQueue Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::addQueueItems Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::addQueueItems Feb 23 13:42:55 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:55 volumio volumio[1260]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::play index 0 Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::play index undefined Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:55 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer Feb 23 13:42:55 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 13:42:55 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 23 13:42:55 volumio volumio[1260]: info: [1771854175691] ControllerWebradio::clearAddPlayTrack Feb 23 13:42:55 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 13:42:57 volumio volumio[1260]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 7533 milliseconds Feb 23 13:42:57 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 13:42:57 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand play Feb 23 13:42:57 volumio volumio[1260]: info: Feb 23 13:42:57 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:42:57 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:42:57 volumio volumio[1260]: info: sendMpdCommand stop took 4616 milliseconds Feb 23 13:42:57 volumio volumio[1260]: info: sendMpdCommand stop took 2003 milliseconds Feb 23 13:42:57 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 13:42:57 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 13:42:57 volumio volumio[1260]: info: sendMpdCommand play took 4 milliseconds Feb 23 13:42:58 volumio volumio[1260]: info: Feb 23 13:42:58 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:42:58 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:42:58 volumio volumio[1260]: info: Feb 23 13:42:58 volumio volumio[1260]: ---------------------------- MPD announces state update: player Feb 23 13:42:58 volumio volumio[1260]: info: ------------------------------ 420ms Feb 23 13:42:58 volumio volumio[1260]: info: sendMpdCommand clear took 420 milliseconds Feb 23 13:42:58 volumio volumio[1260]: info: sendMpdCommand clear took 420 milliseconds Feb 23 13:42:58 volumio volumio[1260]: info: ControllerMpd::getState Feb 23 13:42:58 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Feb 23 13:42:58 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Feb 23 13:42:58 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Feb 23 13:42:58 volumio volumio[1260]: error: updateQueue error: null Feb 23 13:42:58 volumio volumio[1260]: info: ------------------------------ 9ms Feb 23 13:42:58 volumio volumio[1260]: info: sendMpdCommand status took 10 milliseconds Feb 23 13:42:58 volumio volumio[1260]: verbose: ControllerMpd::parseState Feb 23 13:42:58 volumio volumio[1260]: info: ControllerMpd::pushState Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:42:58 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:58 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:58 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:58 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:58 volumio volumio[1260]: 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} Feb 23 13:42:58 volumio volumio[1260]: verbose: CURRENT POSITION 0 Feb 23 13:42:58 volumio volumio[1260]: info: CoreStateMachine::syncState stateService stop Feb 23 13:42:58 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Feb 23 13:42:58 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:58 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:58 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:58 volumio volumio[1260]: info: No code Feb 23 13:42:58 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:42:58 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:42:58 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:42:58 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:58 volumio volumio[1260]: info: ------------------------------ 36ms Feb 23 13:42:58 volumio volumio[1260]: info: Display-configuration --- Volumio status= timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:58 volumio volumio[1260]: info: Display-configuration --- Volumio status=undefined timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:58 volumio volumio[1260]: info: Display-configuration --- Volumio status=undefined timeout=120 noifplay=true screensavertype=dpms Feb 23 13:42:58 volumio volumio[1260]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.WIzrsK85sjUzJb07DMSert4KGSg2.31f2e551b3161132fdc6d99e22e60a2b.state.status' Feb 23 13:42:58 volumio volumio[1260]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.WIzrsK85sjUzJb07DMSert4KGSg2.31f2e551b3161132fdc6d99e22e60a2b.state.status' Feb 23 13:42:58 volumio volumio[1260]: info: Feb 23 13:42:58 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:42:58 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:42:58 volumio volumio[1260]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 488 milliseconds Feb 23 13:42:58 volumio volumio[1260]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 489 milliseconds Feb 23 13:42:58 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 13:42:58 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand play Feb 23 13:42:58 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 13:42:58 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand play Feb 23 13:42:58 volumio volumio[1260]: info: ------------------------------ 1ms Feb 23 13:42:58 volumio volumio[1260]: info: sendMpdCommand play took 0 milliseconds Feb 23 13:42:58 volumio volumio[1260]: info: sendMpdCommand play took 0 milliseconds Feb 23 13:42:59 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::ClearQueue Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::clearPlayQueue Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::addQueueItems Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::addQueueItems Feb 23 13:42:59 volumio volumio[1260]: info: Preload queue cleared Feb 23 13:42:59 volumio volumio[1260]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::saveQueue Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::play index 0 Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::stop Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::play index undefined Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer Feb 23 13:42:59 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 13:42:59 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 23 13:42:59 volumio volumio[1260]: info: [1771854179344] ControllerWebradio::clearAddPlayTrack Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 13:42:59 volumio volumio[1260]: info: Feb 23 13:42:59 volumio volumio[1260]: ---------------------------- MPD announces state update: player Feb 23 13:42:59 volumio volumio[1260]: info: sendMpdCommand stop took 2 milliseconds Feb 23 13:42:59 volumio volumio[1260]: info: ControllerMpd::getState Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 13:42:59 volumio volumio[1260]: info: Feb 23 13:42:59 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:42:59 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:42:59 volumio volumio[1260]: info: sendMpdCommand status took 2 milliseconds Feb 23 13:42:59 volumio volumio[1260]: info: sendMpdCommand clear took 2 milliseconds Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::parseState Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Feb 23 13:42:59 volumio volumio[1260]: error: updateQueue error: null Feb 23 13:42:59 volumio volumio[1260]: info: ------------------------------ 2ms Feb 23 13:42:59 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Feb 23 13:42:59 volumio volumio[1260]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 23 13:42:59 volumio volumio[1260]: info: ------------------------------ 4ms Feb 23 13:42:59 volumio volumio[1260]: info: Feb 23 13:42:59 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:42:59 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:42:59 volumio volumio[1260]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 246 milliseconds Feb 23 13:42:59 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 13:42:59 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand play Feb 23 13:42:59 volumio volumio[1260]: info: ------------------------------ 2ms Feb 23 13:42:59 volumio volumio[1260]: info: sendMpdCommand play took 1 milliseconds Feb 23 13:43:00 volumio volumio[1260]: info: Executing endpoint metavolumio Feb 23 13:43:00 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 23 13:43:02 volumio volumio[1260]: info: Feb 23 13:43:02 volumio volumio[1260]: ---------------------------- MPD announces state update: player Feb 23 13:43:02 volumio volumio[1260]: info: ControllerMpd::getState Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Feb 23 13:43:02 volumio volumio[1260]: info: Feb 23 13:43:02 volumio volumio[1260]: ---------------------------- MPD announces state update: player Feb 23 13:43:02 volumio volumio[1260]: info: sendMpdCommand status took 127 milliseconds Feb 23 13:43:02 volumio volumio[1260]: info: ControllerMpd::getState Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::parseState Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 13:43:02 volumio volumio[1260]: info: sendMpdCommand status took 1 milliseconds Feb 23 13:43:02 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::parseState Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Feb 23 13:43:02 volumio volumio[1260]: info: ControllerMpd::pushState Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:43:02 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:43:02 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5863/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 23 13:43:02 volumio volumio[1260]: verbose: CURRENT POSITION 0 Feb 23 13:43:02 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Feb 23 13:43:02 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Feb 23 13:43:02 volumio volumio[1260]: info: ------------------------------ 129ms Feb 23 13:43:02 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 13:43:02 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Feb 23 13:43:02 volumio volumio[1260]: info: ControllerMpd::pushState Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:43:02 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:43:02 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5863/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 23 13:43:02 volumio volumio[1260]: verbose: CURRENT POSITION 0 Feb 23 13:43:02 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Feb 23 13:43:02 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Feb 23 13:43:02 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 13:43:02 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:43:02 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:43:02 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:43:02 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:43:02 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:43:02 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:43:02 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:43:02 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:43:02 volumio volumio[1260]: info: ------------------------------ 12ms Feb 23 13:43:02 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:43:02 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:43:02 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:43:02 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:43:02 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:43:02 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:43:03 volumio volumio[1260]: info: Feb 23 13:43:03 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:43:03 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:43:03 volumio volumio[1260]: info: Feb 23 13:43:03 volumio volumio[1260]: ---------------------------- MPD announces state update: player Feb 23 13:43:03 volumio volumio[1260]: info: ControllerMpd::getState Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Feb 23 13:43:03 volumio volumio[1260]: info: Feb 23 13:43:03 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Feb 23 13:43:03 volumio volumio[1260]: info: Ignoring MPD Status Update Feb 23 13:43:03 volumio volumio[1260]: info: Feb 23 13:43:03 volumio volumio[1260]: ---------------------------- MPD announces state update: player Feb 23 13:43:03 volumio volumio[1260]: info: ------------------------------ 4ms Feb 23 13:43:03 volumio volumio[1260]: info: sendMpdCommand status took 4 milliseconds Feb 23 13:43:03 volumio volumio[1260]: info: ControllerMpd::getState Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::parseState Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 13:43:03 volumio volumio[1260]: info: ------------------------------ 3ms Feb 23 13:43:03 volumio volumio[1260]: info: sendMpdCommand status took 4 milliseconds Feb 23 13:43:03 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::parseState Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Feb 23 13:43:03 volumio volumio[1260]: info: ControllerMpd::pushState Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:43:03 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:43:03 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 23 13:43:03 volumio volumio[1260]: verbose: CURRENT POSITION 0 Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Feb 23 13:43:03 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:43:03 volumio volumio[1260]: info: ------------------------------ 19ms Feb 23 13:43:03 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 23 13:43:03 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Feb 23 13:43:03 volumio volumio[1260]: info: ControllerMpd::pushState Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Feb 23 13:43:03 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Feb 23 13:43:03 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1226,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 23 13:43:03 volumio volumio[1260]: verbose: CURRENT POSITION 0 Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Feb 23 13:43:03 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:43:03 volumio volumio[1260]: info: CoreStateMachine::pushState Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Feb 23 13:43:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Feb 23 13:43:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Feb 23 13:43:03 volumio volumio[1260]: info: ------------------------------ 30ms Feb 23 13:43:03 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:43:03 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:43:03 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:43:03 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:43:03 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:43:04 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:43:04 volumio volumio[1260]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 23 13:43:04 volumio volumio[1260]: info: Display-configuration --- → Wakeup triggered Feb 23 13:43:04 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:43:04 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:43:04 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:43:04 volumio volumio[1260]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 23 13:43:04 volumio volumio[1260]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 13:43:04 volumio volumio[1260]: TypeError: Cannot read properties of null (reading 'slice') Feb 23 13:43:04 volumio volumio[1260]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 23 13:43:04 volumio volumio[1260]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 23 13:43:04 volumio volumio[1260]: at Object.onceWrapper (node:events:629:26) Feb 23 13:43:04 volumio volumio[1260]: at ClientRequest.emit (node:events:514:28) Feb 23 13:43:04 volumio volumio[1260]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Feb 23 13:43:04 volumio volumio[1260]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Feb 23 13:43:04 volumio volumio[1260]: at TLSSocket.socketOnData (node:_http_client:535:22) Feb 23 13:43:04 volumio volumio[1260]: at TLSSocket.emit (node:events:514:28) Feb 23 13:43:04 volumio volumio[1260]: at addChunk (node:internal/streams/readable:343:12) Feb 23 13:43:04 volumio volumio[1260]: at readableAddChunk (node:internal/streams/readable:316:9) Feb 23 13:43:04 volumio volumio[1260]: at Readable.push (node:internal/streams/readable:253:10) Feb 23 13:43:04 volumio volumio[1260]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Feb 23 13:43:04 volumio volumio[1260]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 13:43:05 volumio sudo[3634]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-23 13:42' Feb 23 13:43:05 volumio sudo[3634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"