-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2024-05-13 21:26:36 CST. --
May 13 21:25:00 volumio volumio[822]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 14
May 13 21:25:00 volumio volumio[822]: info: CoreCommandRouter::volumioGetState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:05 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:05 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:11 volumio volumio-remote-updater[539]: No test mode
May 13 21:25:11 volumio volumio-remote-updater[539]: No alpha test mode
May 13 21:25:11 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 13 21:25:11 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 13 21:25:12 volumio volumio[822]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:12 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:12 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: peppy_screensaver: Start PeppyMeter
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:13 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:13 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:13 volumio volumio[822]: info: touch_display: Setting screensaver timeout to 5 seconds.
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:17 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:17 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:18 volumio volumio[822]: info: touch_display: Setting screensaver timeout to 5 seconds.
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:19 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:19 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:19 volumio shairport-sync[1748]: {"time":1715606696782,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current
May 13 21:25:19 volumio shairport-sync[1748]: Dload Upload Total Spent Left Speed
May 13 21:25:20 volumio volumio[822]: info:
May 13 21:25:20 volumio volumio[822]: ---------------------------- Client requests Stop Airplay Playback
May 13 21:25:20 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback
May 13 21:25:20 volumio volumio[822]: info: Airplay playback stop
May 13 21:25:20 volumio volumio[822]: info: Airplay Playback Stopped, clearing state
May 13 21:25:20 volumio volumio[822]: info: CoreStateMachine::resetVolumioState
May 13 21:25:20 volumio volumio[822]: info: CoreStateMachine::getcurrentVolume
May 13 21:25:20 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:25:20 volumio shairport-sync[1748]: [158B blob data]
May 13 21:25:20 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:25:20 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:20 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:20 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock
May 13 21:25:20 volumio volumio[822]: info: CorePlayQueue::getTrackBlock
May 13 21:25:20 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:25:20 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:25:20 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:20 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:21 volumio volumio[822]: info: Airplay started streaming, receiving metadatas
May 13 21:25:21 volumio shairport-sync[1748]: {"time":1715606720013,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current
May 13 21:25:21 volumio shairport-sync[1748]: Dload Upload Total Spent Left Speed
May 13 21:25:21 volumio volumio[822]: info:
May 13 21:25:21 volumio volumio[822]: ---------------------------- Client requests Start Airplay PlaybackRoutine
May 13 21:25:21 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
May 13 21:25:21 volumio volumio[822]: info: Airplay playback start
May 13 21:25:21 volumio shairport-sync[1748]: [158B blob data]
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:22 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:22 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:28 volumio volumio[822]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object]
May 13 21:25:28 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf
May 13 21:25:28 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:28 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:28 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
May 13 21:25:28 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:28 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:28 volumio sudo[1838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/shairport-sync.conf.tmpl /volumio/app/plugins/music_service/airplay_emulation/shairport-sync.conf.tmpl
May 13 21:25:28 volumio sudo[1838]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:28 volumio sudo[1838]: pam_unix(sudo:session): session closed for user root
May 13 21:25:28 volumio volumio[822]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 21:25:28 volumio volumio[822]: info: Starting Shairport Sync
May 13 21:25:28 volumio sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 13 21:25:28 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 13 21:25:28 volumio shairport-sync[1748]: {"time":1715606721153,"response":"startAirplayPlayback Success"}
May 13 21:25:28 volumio systemd[1]: shairport-sync.service: Succeeded.
May 13 21:25:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 13 21:25:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 13 21:25:28 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root
May 13 21:25:28 volumio volumio[822]: info: Shairport-Sync Started
May 13 21:25:45 volumio volumio[822]: info: CoreCommandRouter::getUIConfigOnPlugin
May 13 21:25:45 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 13 21:25:45 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:45 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 13 21:25:46 volumio volumio[822]: info: Airplay started streaming, receiving metadatas
May 13 21:25:46 volumio shairport-sync[1846]: % Total % Received % Xferd Average Speed Time Time Time Current
May 13 21:25:46 volumio shairport-sync[1846]: Dload Upload Total Spent Left Speed
May 13 21:25:46 volumio volumio[822]: info:
May 13 21:25:46 volumio volumio[822]: ---------------------------- Client requests Start Airplay PlaybackRoutine
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
May 13 21:25:46 volumio volumio[822]: info: Airplay playback start
May 13 21:25:46 volumio shairport-sync[1846]: [158B blob data]
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:46 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:46 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:46 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:46 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:46 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:46 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:46 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:47 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:47 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:25:50 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:50 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:53 volumio volumio[822]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 8
May 13 21:25:53 volumio volumio[822]: info: CoreCommandRouter::volumioGetState
May 13 21:25:53 volumio volumio[822]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 9
May 13 21:25:53 volumio volumio[822]: info: CoreCommandRouter::volumioGetState
May 13 21:25:54 volumio volumio[822]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
May 13 21:25:54 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
May 13 21:25:54 volumio volumio[822]: info: Preparing to save Alsa Options, stopping services first
May 13 21:25:54 volumio volumio[822]: info: CoreCommandRouter::volumioGetState
May 13 21:25:54 volumio volumio[822]: info: CoreCommandRouter::volumioPause
May 13 21:25:54 volumio volumio[822]: info: CoreStateMachine::pause
May 13 21:25:54 volumio volumio[822]: info: CoreStateMachine::stPlaybackTimer
May 13 21:25:54 volumio volumio[822]: info: CoreStateMachine::servicePause
May 13 21:25:54 volumio volumio[822]: info: CoreCommandRouter::servicePause
May 13 21:25:54 volumio volumio[822]: info: Airplay Pause with DBUS Call
May 13 21:25:54 volumio volumio[822]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"Headphones"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
May 13 21:25:54 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 13 21:25:54 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 13 21:25:54 volumio volumio[822]: info: Found match in Cards Database: setting mixer PCM for card Headphones
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::volumioUpdateVolumeSettings
May 13 21:25:55 volumio volumio[822]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
May 13 21:25:55 volumio volumio[822]: info: Disabling external Volume Control
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::getUIConfigOnPlugin
May 13 21:25:55 volumio volumio[822]: info: Preparing to generate the ALSA configuration file
May 13 21:25:55 volumio volumio[822]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
May 13 21:25:55 volumio volumio[822]: info: Reading ALSA contributions from plugins.
May 13 21:25:55 volumio volumio[822]: info: Error Airplay DBUS Call Pause: Error: Command failed: /usr/bin/dbus-send --system --print-reply --type=method_call --dest=org.gnome.ShairportSync '/org/gnome/ShairportSync' org.gnome.ShairportSync.RemoteControl.Pause
May 13 21:25:55 volumio volumio[822]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 13 21:25:55 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:25:55 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:55 volumio volumio[822]: info: Asound.conf file written
May 13 21:25:55 volumio sudo[1904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 13 21:25:55 volumio sudo[1904]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:55 volumio sudo[1904]: pam_unix(sudo:session): session closed for user root
May 13 21:25:55 volumio volumio[822]: info: Output device has changed, restarting MPD
May 13 21:25:55 volumio sudo[1910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 21:25:55 volumio sudo[1910]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:55 volumio volumio[822]: info: Output device has changed, restarting Shairport Sync
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:55 volumio sudo[1910]: pam_unix(sudo:session): session closed for user root
May 13 21:25:55 volumio sudo[1913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 21:25:55 volumio sudo[1913]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:55 volumio systemd[1]: Stopping Music Player Daemon...
May 13 21:25:55 volumio volumio[822]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 21:25:55 volumio volumio[822]: info: Output device has changed, restarting MPD
May 13 21:25:55 volumio systemd[1]: mpd.service: Succeeded.
May 13 21:25:55 volumio systemd[1]: Stopped Music Player Daemon.
May 13 21:25:55 volumio sudo[1920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 21:25:55 volumio sudo[1920]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:55 volumio volumio[822]: info: Output device has changed, restarting Shairport Sync
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 21:25:55 volumio volumio[822]: info: MPD Permissions set
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio sudo[1920]: pam_unix(sudo:session): session closed for user root
May 13 21:25:55 volumio systemd[1]: Starting Music Player Daemon...
May 13 21:25:55 volumio sudo[1923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 21:25:55 volumio sudo[1923]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:55 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 13 21:25:55 volumio systemd[1]: mpd.service: Succeeded.
May 13 21:25:55 volumio systemd[1]: Stopped Music Player Daemon.
May 13 21:25:55 volumio systemd[1]: Starting Music Player Daemon...
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: Starting Shairport Sync
May 13 21:25:55 volumio volumio[822]: info: Starting Shairport Sync
May 13 21:25:55 volumio sudo[1938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 13 21:25:55 volumio sudo[1938]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:55 volumio sudo[1940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 13 21:25:55 volumio sudo[1940]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 13 21:25:55 volumio shairport-sync[1846]: {"time":1715606746750,"response":"startAirplayPlayback Success"}
May 13 21:25:55 volumio systemd[1]: shairport-sync.service: Succeeded.
May 13 21:25:55 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 13 21:25:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 13 21:25:55 volumio sudo[1940]: pam_unix(sudo:session): session closed for user root
May 13 21:25:55 volumio sudo[1938]: pam_unix(sudo:session): session closed for user root
May 13 21:25:55 volumio volumio[822]: info: Shairport-Sync Started
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:55 volumio volumio[822]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
May 13 21:25:55 volumio volumio[822]: info: Preparing to save Alsa Options, stopping services first
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::volumioGetState
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::volumioPause
May 13 21:25:55 volumio volumio[822]: info: CoreStateMachine::pause
May 13 21:25:55 volumio volumio[822]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"Headphones"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
May 13 21:25:55 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 13 21:25:56 volumio volumio[822]: info: Found match in Cards Database: setting mixer PCM for card Headphones
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::volumioUpdateVolumeSettings
May 13 21:25:56 volumio volumio[822]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
May 13 21:25:56 volumio volumio[822]: info: Disabling external Volume Control
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::getUIConfigOnPlugin
May 13 21:25:56 volumio volumio[822]: info: Preparing to generate the ALSA configuration file
May 13 21:25:56 volumio volumio[822]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
May 13 21:25:56 volumio volumio[822]: info: Reading ALSA contributions from plugins.
May 13 21:25:56 volumio mpd[1932]: May 13 21:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 13 21:25:56 volumio systemd[1]: Started Music Player Daemon.
May 13 21:25:56 volumio sudo[1913]: pam_unix(sudo:session): session closed for user root
May 13 21:25:56 volumio sudo[1923]: pam_unix(sudo:session): session closed for user root
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 13 21:25:56 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:25:56 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:56 volumio volumio[822]: error: MPD error: The expression evaluated to a falsy value:
May 13 21:25:56 volumio volumio[822]: assert.ok(self.idling)
May 13 21:25:56 volumio volumio[822]: error: The expression evaluated to a falsy value:
May 13 21:25:56 volumio volumio[822]: assert.ok(self.idling)
May 13 21:25:56 volumio volumio[822]: error: updateQueue error: null
May 13 21:25:56 volumio volumio[822]: info: Asound.conf file unchanged, so no further update is needed
May 13 21:25:56 volumio volumio[822]: info: Output device has changed, restarting MPD
May 13 21:25:56 volumio sudo[1962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 13 21:25:56 volumio sudo[1962]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:56 volumio volumio[822]: info: Output device has changed, restarting Shairport Sync
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:56 volumio sudo[1962]: pam_unix(sudo:session): session closed for user root
May 13 21:25:56 volumio sudo[1966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 13 21:25:56 volumio sudo[1966]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:56 volumio systemd[1]: Stopping Music Player Daemon...
May 13 21:25:56 volumio volumio[822]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 13 21:25:56 volumio volumio[822]: info: MPD Permissions set
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio systemd[1]: mpd.service: Succeeded.
May 13 21:25:56 volumio systemd[1]: Stopped Music Player Daemon.
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: Starting Shairport Sync
May 13 21:25:56 volumio systemd[1]: Starting Music Player Daemon...
May 13 21:25:56 volumio sudo[1976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 13 21:25:56 volumio sudo[1976]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 13 21:25:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 13 21:25:56 volumio systemd[1]: shairport-sync.service: Succeeded.
May 13 21:25:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 13 21:25:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 13 21:25:56 volumio sudo[1976]: pam_unix(sudo:session): session closed for user root
May 13 21:25:56 volumio volumio[822]: info: Shairport-Sync Started
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:56 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 13 21:25:57 volumio mpd[1970]: May 13 21:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 13 21:25:57 volumio systemd[1]: Started Music Player Daemon.
May 13 21:25:57 volumio sudo[1966]: pam_unix(sudo:session): session closed for user root
May 13 21:25:57 volumio volumio[822]: error: updateQueue error: null
May 13 21:25:59 volumio volumio[822]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
May 13 21:25:59 volumio volumio[822]: info: CoreStateMachine::getcurrentVolume
May 13 21:25:59 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:25:59 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:25:59 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:59 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:59 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:25:59 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock
May 13 21:25:59 volumio volumio[822]: info: CorePlayQueue::getTrackBlock
May 13 21:25:59 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:25:59 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:25:59 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:25:59 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:25:59 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:00 volumio volumio[822]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
May 13 21:26:00 volumio volumio[822]: info: CoreStateMachine::getcurrentVolume
May 13 21:26:00 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:26:00 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:26:00 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:00 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:26:00 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:00 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock
May 13 21:26:00 volumio volumio[822]: info: CorePlayQueue::getTrackBlock
May 13 21:26:00 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:26:00 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:26:00 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:00 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:24 volumio volumio[822]: info: Airplay started streaming, receiving metadatas
May 13 21:26:24 volumio volumio[822]: info: Airplay started streaming, receiving metadatas
May 13 21:26:24 volumio volumio[822]: info: Airplay started streaming, receiving metadatas
May 13 21:26:24 volumio volumio[822]: info: Airplay started streaming, receiving metadatas
May 13 21:26:24 volumio shairport-sync[1978]: % Total % Received % Xferd Average Speed Time Time Time Current
May 13 21:26:24 volumio shairport-sync[1978]: Dload Upload Total Spent Left Speed
May 13 21:26:24 volumio volumio[822]: info:
May 13 21:26:24 volumio volumio[822]: ---------------------------- Client requests Start Airplay PlaybackRoutine
May 13 21:26:24 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
May 13 21:26:24 volumio volumio[822]: info: Airplay playback start
May 13 21:26:24 volumio shairport-sync[1978]: [158B blob data]
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio shairport-sync[1978]: {"time":1715606784090,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current
May 13 21:26:25 volumio shairport-sync[1978]: Dload Upload Total Spent Left Speed
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::servicePushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 10
May 13 21:26:25 volumio volumio[822]: info:
May 13 21:26:25 volumio volumio[822]: ---------------------------- Client requests Stop Airplay Playback
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback
May 13 21:26:25 volumio volumio[822]: info: Airplay playback stop
May 13 21:26:25 volumio volumio[822]: info: Airplay Playback Stopped, clearing state
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::resetVolumioState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::getcurrentVolume
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:26:25 volumio shairport-sync[1978]: [158B blob data]
May 13 21:26:25 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::updateTrackBlock
May 13 21:26:25 volumio volumio[822]: info: CorePlayQueue::getTrackBlock
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioRetrievevolume
May 13 21:26:25 volumio volumio[822]: info: VolumeController:: Volume=86 Mute =false
May 13 21:26:25 volumio volumio[822]: info: CoreStateMachine::pushState
May 13 21:26:25 volumio volumio[822]: info: CoreCommandRouter::volumioPushState
May 13 21:26:26 volumio volumio[822]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 11
May 13 21:26:26 volumio volumio[822]: info: CoreCommandRouter::volumioGetState
May 13 21:26:35 volumio volumio[822]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 21:26:35 volumio volumio[822]: Error: connect ETIMEDOUT 168.143.171.93:443
May 13 21:26:35 volumio volumio[822]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
May 13 21:26:35 volumio volumio[822]: errno: -110,
May 13 21:26:35 volumio volumio[822]: code: 'ETIMEDOUT',
May 13 21:26:35 volumio volumio[822]: syscall: 'connect',
May 13 21:26:35 volumio volumio[822]: address: '168.143.171.93',
May 13 21:26:35 volumio volumio[822]: port: 443
May 13 21:26:35 volumio volumio[822]: }
May 13 21:26:35 volumio volumio[822]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 21:26:36 volumio sudo[2066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-13 21:25
May 13 21:26:36 volumio sudo[2066]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"