-- Logs begin at Sat 2024-10-19 07:54:03 UTC, end at Sat 2024-10-19 08:01:11 UTC. -- Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Oct 19 08:00:20 volumio shairport-sync[2326]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory Oct 19 08:00:20 volumio shairport-sync[2326]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 19 08:00:20 volumio shairport-sync[2326]: Dload Upload Total Spent Left Speed Oct 19 08:00:20 volumio volumio[969]: info: Oct 19 08:00:20 volumio volumio[969]: ---------------------------- Client requests AirplayActive Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Oct 19 08:00:20 volumio shairport-sync[2326]: [211B blob data] Oct 19 08:00:20 volumio shairport-sync[2326]: Time{"time":1729324820902,"response":"airplayActive Success"} Time Current Oct 19 08:00:20 volumio shairport-sync[2326]: Dload Upload Total Spent Left Speed Oct 19 08:00:20 volumio volumio[969]: info: Oct 19 08:00:20 volumio volumio[969]: ---------------------------- Client requests Start Airplay PlaybackRoutine Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Oct 19 08:00:20 volumio volumio[969]: info: Airplay playback start Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stPlaybackTimer Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:20 volumio shairport-sync[2326]: [155B blob data] Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::serviceStop Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::serviceStop Oct 19 08:00:20 volumio volumio[969]: info: ControllerMpd::stop Oct 19 08:00:20 volumio volumio[969]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: sendMpdCommand stop took 5 milliseconds Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: info: Airplay started streaming, receiving metadatas Oct 19 08:00:20 volumio volumio[969]: info: CorePlayQueue::getTrack 7 Oct 19 08:00:20 volumio volumio[969]: info: CoreCommandRouter::volumioStop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::stop Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:20 volumio volumio[969]: UNSET VOLATILE Oct 19 08:00:20 volumio volumio[969]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:21 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:21 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::servicePushState Oct 19 08:00:22 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:22 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:27 volumio kernel: usb 1-1.4: USB disconnect, device number 10 Oct 19 08:00:27 volumio kernel: usb 1-1.4: cannot submit urb (err = -19) Oct 19 08:00:27 volumio volumio[969]: info: Oct 19 08:00:27 volumio volumio[969]: ---------------------------- USB Audio Device Detached Oct 19 08:00:27 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Oct 19 08:00:27 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 08:00:27 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 19 08:00:27 volumio kernel: usb 1-1.4: new high-speed USB device number 11 using xhci_hcd Oct 19 08:00:28 volumio kernel: usb 1-1.4: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.04 Oct 19 08:00:28 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Oct 19 08:00:28 volumio kernel: usb 1-1.4: Product: D70 Oct 19 08:00:28 volumio kernel: usb 1-1.4: Manufacturer: Topping Oct 19 08:00:28 volumio kernel: usb 1-1.4: 1:3 : unsupported format bits 0x100000000 Oct 19 08:00:28 volumio volumio[969]: info: Oct 19 08:00:28 volumio volumio[969]: ---------------------------- USB Audio Device Attached Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::Close All Modals sent Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 08:00:28 volumio volumio[969]: info: Output device has changed, restarting MPD Oct 19 08:00:28 volumio sudo[2510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 19 08:00:28 volumio volumio[969]: info: Output device has changed, restarting Shairport Sync Oct 19 08:00:28 volumio sudo[2510]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 08:00:28 volumio sudo[2510]: pam_unix(sudo:session): session closed for user root Oct 19 08:00:28 volumio sudo[2512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 08:00:28 volumio sudo[2512]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 08:00:28 volumio systemd[1]: Stopping Music Player Daemon... Oct 19 08:00:28 volumio volumio[969]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 08:00:28 volumio volumio[969]: info: Setting mixer D70 for card D70 Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 19 08:00:28 volumio volumio[969]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: D70 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Oct 19 08:00:28 volumio systemd[1]: Starting Music Player Daemon... Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:00:28 volumio volumio[969]: info: MPD Permissions set Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 08:00:28 volumio volumio[969]: info: Starting Shairport Sync Oct 19 08:00:28 volumio volumio[969]: info: VolumeController:: Volume=100 Mute =false Oct 19 08:00:28 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:28 volumio sudo[2548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 08:00:28 volumio sudo[2548]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 08:00:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 08:00:28 volumio shairport-sync[2326]: {"time":1729324820907,"response":"startAirplayPlayback Success"} Oct 19 08:00:28 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 19 08:00:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 08:00:28 volumio sudo[2548]: pam_unix(sudo:session): session closed for user root Oct 19 08:00:28 volumio volumio[969]: info: Shairport-Sync Started Oct 19 08:00:28 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Oct 19 08:00:29 volumio systemd[1]: Started Music Player Daemon. Oct 19 08:00:29 volumio sudo[2512]: pam_unix(sudo:session): session closed for user root Oct 19 08:00:29 volumio volumio[969]: error: updateQueue error: null Oct 19 08:00:30 volumio volumio[969]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 19 08:00:30 volumio volumio[969]: info: CoreStateMachine::getcurrentVolume Oct 19 08:00:30 volumio volumio[969]: info: CoreCommandRouter::volumioRetrievevolume Oct 19 08:00:30 volumio volumio[969]: info: VolumeController:: Volume=100 Mute =false Oct 19 08:00:30 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:30 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:30 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:30 volumio volumio[969]: info: CoreStateMachine::updateTrackBlock Oct 19 08:00:30 volumio volumio[969]: info: CorePlayQueue::getTrackBlock Oct 19 08:00:30 volumio volumio[969]: info: CoreCommandRouter::volumioRetrievevolume Oct 19 08:00:31 volumio volumio[969]: info: VolumeController:: Volume=100 Mute =false Oct 19 08:00:31 volumio volumio[969]: info: CoreStateMachine::pushState Oct 19 08:00:31 volumio volumio[969]: info: CoreCommandRouter::volumioPushState Oct 19 08:00:31 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 08:00:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 08:00:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 08:00:36 volumio volumio[969]: info: Discovery: Getting this device information Oct 19 08:00:36 volumio volumio[969]: info: CoreCommandRouter::volumioGetState Oct 19 08:00:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 19 08:00:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 19 08:00:36 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 19 08:00:38 volumio volumio[969]: info: CoreCommandRouter::volumioGetState Oct 19 08:00:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 19 08:00:38 volumio volumio[969]: info: Listing playlists Oct 19 08:00:38 volumio volumio[969]: info: CoreCommandRouter::volumioGetQueue Oct 19 08:00:38 volumio volumio[969]: info: CoreStateMachine::getQueue Oct 19 08:00:38 volumio volumio[969]: info: CorePlayQueue::getQueue Oct 19 08:00:38 volumio volumio[969]: info: CoreCommandRouter::volumioGetVisibleSources Oct 19 08:00:38 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 08:00:45 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 08:00:45 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 08:00:45 volumio volumio[969]: info: Discovery: Getting this device information Oct 19 08:00:45 volumio volumio[969]: info: CoreCommandRouter::volumioGetState Oct 19 08:00:45 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 19 08:00:45 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 19 08:00:45 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:00:53 volumio volumio[969]: info: Retrieving Cloud Streaming UI Oct 19 08:00:53 volumio volumio[969]: info: Getting Tidal Cloud Configuration Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:00:53 volumio volumio[969]: info: Getting Qobuz Cloud Configuration Oct 19 08:00:53 volumio volumio[969]: info: Asking plugin for UI Config Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:00:53 volumio volumio[969]: info: Getting Spotify Cloud Configuration Oct 19 08:00:53 volumio volumio[969]: info: Asking plugin for UI Config Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:00:53 volumio volumio[969]: info: Saving Spotify Acccount Oct 19 08:00:53 volumio volumio[969]: info: Got Tidal Cloud Configuration Oct 19 08:00:53 volumio volumio[969]: info: Got it Oct 19 08:00:53 volumio volumio[969]: info: Got it Oct 19 08:00:53 volumio volumio[969]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:00:53 volumio volumio[969]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 08:00:53 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 19 08:00:57 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 08:01:01 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 19 08:01:04 volumio volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 08:01:10 volumio volumio[969]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 08:01:10 volumio volumio[969]: { Error: connect ETIMEDOUT 54.234.18.200:443 Oct 19 08:01:10 volumio volumio[969]: at Object._errnoException (util.js:1022:11) Oct 19 08:01:10 volumio volumio[969]: at _exceptionWithHostPort (util.js:1044:20) Oct 19 08:01:10 volumio volumio[969]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 19 08:01:10 volumio volumio[969]: code: 'ETIMEDOUT', Oct 19 08:01:10 volumio volumio[969]: errno: 'ETIMEDOUT', Oct 19 08:01:10 volumio volumio[969]: syscall: 'connect', Oct 19 08:01:10 volumio volumio[969]: address: '54.234.18.200', Oct 19 08:01:10 volumio volumio[969]: port: 443 } Oct 19 08:01:10 volumio volumio[969]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 08:01:11 volumio sudo[2639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 08:00 Oct 19 08:01:11 volumio sudo[2639]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"