-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2026-08-31 18:48:49 CEST. -- Aug 31 18:47:04 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:04 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:08 volumio volumio[874]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 31 18:47:08 volumio volumio[874]: info: Preparing to save Alsa Options, stopping services first Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::volumioGetState Aug 31 18:47:08 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::volumioPause Aug 31 18:47:08 volumio volumio[874]: info: CoreStateMachine::pause Aug 31 18:47:08 volumio volumio[874]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"allo-boss-dac","label":"Allo BOSS"}} Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: Found match in i2s Card Database: setting mixer Digital for card Allo BOSS Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 31 18:47:08 volumio volumio[874]: info: Updating Volume Controller Parameters: Device: 2 Name: Allo BOSS Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 31 18:47:08 volumio volumio[874]: info: Disabling external Volume Control Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 18:47:08 volumio volumio[874]: info: Preparing to generate the ALSA configuration file Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 18:47:08 volumio volumio[874]: info: Getting Alsa Cards List without I2S DAC Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 18:47:08 volumio volumio[874]: info: Asound.conf file unchanged, so no further update is needed Aug 31 18:47:08 volumio volumio[874]: info: Output device has changed, restarting MPD Aug 31 18:47:08 volumio sudo[5589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 18:47:08 volumio sudo[5589]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 18:47:08 volumio sudo[5589]: pam_unix(sudo:session): session closed for user root Aug 31 18:47:08 volumio volumio[874]: info: Output device has changed, restarting Shairport Sync Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:08 volumio sudo[5592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 18:47:08 volumio sudo[5592]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 18:47:08 volumio systemd[1]: Stopping Music Player Daemon... Aug 31 18:47:08 volumio volumio[874]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 18:47:08 volumio volumio[874]: info: VolumeController:: Volume=100 Mute =false Aug 31 18:47:08 volumio volumio[874]: info: CoreStateMachine::pushState Aug 31 18:47:08 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState Aug 31 18:47:08 volumio volumio[874]: info: MPD Permissions set Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:08 volumio systemd[1]: mpd.service: Succeeded. Aug 31 18:47:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:08 volumio systemd[1]: Stopped Music Player Daemon. Aug 31 18:47:08 volumio volumio[874]: info: Starting Shairport Sync Aug 31 18:47:08 volumio sudo[5603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 18:47:08 volumio sudo[5603]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 18:47:08 volumio systemd[1]: Starting Music Player Daemon... Aug 31 18:47:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 18:47:08 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 31 18:47:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 18:47:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 18:47:08 volumio sudo[5603]: pam_unix(sudo:session): session closed for user root Aug 31 18:47:08 volumio volumio[874]: info: Shairport-Sync Started Aug 31 18:47:08 volumio sudo[5601]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 18:47:08 volumio sudo[5601]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 18:47:08 volumio sudo[5601]: pam_unix(sudo:session): session closed for user root Aug 31 18:47:10 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:10 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:10 volumio mpd[5610]: Aug 31 18:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 31 18:47:10 volumio systemd[1]: Started Music Player Daemon. Aug 31 18:47:10 volumio sudo[5592]: pam_unix(sudo:session): session closed for user root Aug 31 18:47:10 volumio volumio[874]: error: updateQueue error: null Aug 31 18:47:12 volumio volumio[874]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 31 18:47:12 volumio volumio[874]: info: CoreStateMachine::getcurrentVolume Aug 31 18:47:12 volumio volumio[874]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 18:47:12 volumio volumio[874]: info: VolumeController:: Volume=100 Mute =false Aug 31 18:47:12 volumio volumio[874]: info: CoreStateMachine::pushState Aug 31 18:47:12 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:47:12 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 18:47:12 volumio volumio[874]: info: CoreCommandRouter::volumioPushState Aug 31 18:47:12 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:47:12 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:47:12 volumio volumio[874]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 18:47:12 volumio volumio[874]: info: VolumeController:: Volume=100 Mute =false Aug 31 18:47:12 volumio volumio[874]: info: CoreStateMachine::pushState Aug 31 18:47:12 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:47:12 volumio volumio[874]: info: CoreCommandRouter::volumioPushState Aug 31 18:47:15 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:15 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:20 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:20 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:25 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:25 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:30 volumio volumio[874]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Aug 31 18:47:30 volumio sudo[5655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 18:47:30 volumio sudo[5655]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 18:47:30 volumio sudo[5655]: pam_unix(sudo:session): session closed for user root Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio sudo[5658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 18:47:30 volumio sudo[5658]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 18:47:30 volumio volumio[874]: info: MPD Permissions set Aug 31 18:47:30 volumio systemd[1]: Stopping Music Player Daemon... Aug 31 18:47:30 volumio systemd[1]: mpd.service: Succeeded. Aug 31 18:47:30 volumio systemd[1]: Stopped Music Player Daemon. Aug 31 18:47:30 volumio systemd[1]: Starting Music Player Daemon... Aug 31 18:47:30 volumio sudo[5664]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 18:47:30 volumio sudo[5664]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 18:47:30 volumio sudo[5664]: pam_unix(sudo:session): session closed for user root Aug 31 18:47:30 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:30 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:31 volumio mpd[5668]: Aug 31 18:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 31 18:47:31 volumio systemd[1]: Started Music Player Daemon. Aug 31 18:47:31 volumio sudo[5658]: pam_unix(sudo:session): session closed for user root Aug 31 18:47:31 volumio volumio[874]: error: updateQueue error: null Aug 31 18:47:35 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:35 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:40 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:40 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:45 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:45 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:51 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:51 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:47:56 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:47:56 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:01 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:01 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:01 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 31 18:48:01 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 18:48:01 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:03 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 31 18:48:03 volumio volumio[874]: info: Getting webradio selection Aug 31 18:48:03 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:06 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:06 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:06 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:06 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:06 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:06 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:06 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:06 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:06 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:06 volumio volumio[874]: info: Adding Item to queue: https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3 Aug 31 18:48:06 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:06 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:06 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:06 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:06 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:06 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:06 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:06 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:06 volumio volumio[874]: info: [1788194886589] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:06 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:06 volumio volumio[874]: info: sendMpdCommand stop took 4 milliseconds Aug 31 18:48:06 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:06 volumio volumio[874]: info: Aug 31 18:48:06 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:06 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:06 volumio volumio[874]: info: sendMpdCommand clear took 2 milliseconds Aug 31 18:48:06 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Aug 31 18:48:06 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:06 volumio volumio[874]: info: ------------------------------ 5ms Aug 31 18:48:10 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Aug 31 18:48:10 volumio volumio[874]: info: Aug 31 18:48:10 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:10 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:10 volumio volumio[874]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 2 milliseconds Aug 31 18:48:10 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 31 18:48:10 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand play Aug 31 18:48:10 volumio volumio[874]: info: ------------------------------ 5ms Aug 31 18:48:10 volumio volumio[874]: info: sendMpdCommand play took 4 milliseconds Aug 31 18:48:11 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:11 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:11 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:11 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:11 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:11 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:11 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:11 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:11 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:11 volumio volumio[874]: info: Adding Item to queue: https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3 Aug 31 18:48:11 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:11 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:11 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:11 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:11 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:11 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:11 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:11 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:11 volumio volumio[874]: info: [1788194891828] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:11 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:11 volumio volumio[874]: info: Aug 31 18:48:11 volumio volumio[874]: ---------------------------- MPD announces state update: player Aug 31 18:48:11 volumio volumio[874]: info: sendMpdCommand stop took 4 milliseconds Aug 31 18:48:11 volumio volumio[874]: info: ControllerMpd::getState Aug 31 18:48:11 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status Aug 31 18:48:11 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:11 volumio volumio[874]: info: sendMpdCommand status took 13 milliseconds Aug 31 18:48:11 volumio volumio[874]: verbose: ControllerMpd::parseState Aug 31 18:48:11 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 18:48:11 volumio volumio[874]: info: Aug 31 18:48:11 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:11 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:11 volumio volumio[874]: info: sendMpdCommand clear took 16 milliseconds Aug 31 18:48:11 volumio volumio[874]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 31 18:48:11 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Aug 31 18:48:11 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo Aug 31 18:48:11 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 31 18:48:11 volumio volumio[874]: info: ------------------------------ 24ms Aug 31 18:48:11 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:11 volumio volumio[874]: info: ------------------------------ 6ms Aug 31 18:48:13 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:13 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:13 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:13 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:13 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:13 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:13 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:13 volumio volumio[874]: info: Adding Item to queue: https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3 Aug 31 18:48:13 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:13 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:13 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:13 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:13 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:13 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:13 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:13 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:13 volumio volumio[874]: info: [1788194893475] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:13 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:14 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:14 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:14 volumio volumio[874]: info: Adding Item to queue: https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3 Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:14 volumio volumio[874]: info: [1788194894543] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:14 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:14 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:14 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:14 volumio volumio[874]: info: Adding Item to queue: https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3 Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:14 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:14 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:14 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:14 volumio volumio[874]: info: [1788194894754] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:14 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:16 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:16 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:16 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:16 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:16 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:16 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:16 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:16 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:16 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:16 volumio volumio[874]: info: Adding Item to queue: http://media-ice.musicradio.com/ClassicFMMP3 Aug 31 18:48:16 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:16 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:16 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:16 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:16 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:16 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:16 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:16 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:16 volumio volumio[874]: info: [1788194896784] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:16 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:18 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:18 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:18 volumio volumio[874]: info: Adding Item to queue: http://media-ice.musicradio.com/ClassicFMMP3 Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:18 volumio volumio[874]: info: [1788194898191] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:18 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:18 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:18 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:18 volumio volumio[874]: info: Adding Item to queue: http://media-ice.musicradio.com/ClassicFMMP3 Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:18 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:18 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:18 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:18 volumio volumio[874]: info: [1788194898928] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:18 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:20 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:20 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:20 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:20 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:20 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:20 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:20 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:20 volumio volumio[874]: info: Adding Item to queue: http://media-ice.musicradio.com/ClassicFMMP3 Aug 31 18:48:20 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:20 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:20 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:20 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:20 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:20 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:20 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:20 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:20 volumio volumio[874]: info: [1788194900685] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:20 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:21 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:21 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand stop took 8848 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand stop took 7781 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand stop took 7570 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand stop took 5539 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand stop took 4132 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand stop took 3397 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand stop took 1640 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" took 4 milliseconds Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 18:48:22 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand play Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: Aug 31 18:48:22 volumio volumio[874]: ---------------------------- MPD announces system playlist update Aug 31 18:48:22 volumio volumio[874]: info: Ignoring MPD Status Update Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 11ms Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand clear took 8 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand clear took 11 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand clear took 11 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand clear took 12 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand clear took 12 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand clear took 11 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand clear took 12 milliseconds Aug 31 18:48:22 volumio volumio[874]: info: sendMpdCommand play took 12 milliseconds Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "http://media-ice.musicradio.com/ClassicFMMP3" Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "http://media-ice.musicradio.com/ClassicFMMP3" Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "http://media-ice.musicradio.com/ClassicFMMP3" Aug 31 18:48:22 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand load "http://media-ice.musicradio.com/ClassicFMMP3" Aug 31 18:48:22 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:22 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:22 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:22 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:22 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:22 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:22 volumio volumio[874]: error: updateQueue error: null Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 16ms Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 16ms Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 15ms Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 15ms Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 15ms Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 14ms Aug 31 18:48:22 volumio volumio[874]: info: ------------------------------ 14ms Aug 31 18:48:25 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:25 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:25 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:25 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:25 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:25 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:25 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:25 volumio volumio[874]: info: Adding Item to queue: http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3 Aug 31 18:48:25 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:25 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:25 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:25 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:25 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:25 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:25 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:25 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:25 volumio volumio[874]: info: [1788194905688] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:25 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:26 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:26 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:27 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:27 volumio volumio[874]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::ClearQueue Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:27 volumio volumio[874]: info: CorePlayQueue::clearPlayQueue Aug 31 18:48:27 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:27 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::addQueueItems Aug 31 18:48:27 volumio volumio[874]: info: CorePlayQueue::addQueueItems Aug 31 18:48:27 volumio volumio[874]: info: Preload queue cleared Aug 31 18:48:27 volumio volumio[874]: info: Adding Item to queue: http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3 Aug 31 18:48:27 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 18:48:27 volumio volumio[874]: info: CoreCommandRouter::volumioPushQueue Aug 31 18:48:27 volumio volumio[874]: info: CorePlayQueue::saveQueue Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock Aug 31 18:48:27 volumio volumio[874]: info: CorePlayQueue::getTrackBlock Aug 31 18:48:27 volumio volumio[874]: info: CoreCommandRouter::volumioPlay Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::play index 0 Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::stop Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::play index undefined Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 18:48:27 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:27 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer Aug 31 18:48:27 volumio volumio[874]: info: CorePlayQueue::getTrack 0 Aug 31 18:48:27 volumio volumio[874]: info: [1788194907519] ControllerWebradio::clearAddPlayTrack Aug 31 18:48:27 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 18:48:31 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:31 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 18:48:32 volumio volumio[874]: info: Retrieving Cloud Streaming UI Aug 31 18:48:32 volumio volumio[874]: info: Getting Tidal Cloud Configuration Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 18:48:32 volumio volumio[874]: info: Getting Qobuz Cloud Configuration Aug 31 18:48:32 volumio volumio[874]: info: Asking plugin for UI Config Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 18:48:32 volumio volumio[874]: info: Getting Spotify Cloud Configuration Aug 31 18:48:32 volumio volumio[874]: info: Asking plugin for UI Config Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 18:48:32 volumio volumio[874]: info: Saving Spotify Acccount Aug 31 18:48:32 volumio volumio[874]: info: Got Tidal Cloud Configuration Aug 31 18:48:32 volumio volumio[874]: info: Got it Aug 31 18:48:32 volumio volumio[874]: info: Got it Aug 31 18:48:32 volumio volumio[874]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 18:48:32 volumio volumio[874]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::volumioGetBrowseSources Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::volumioGetBrowseSources Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::volumioGetBrowseSources Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 18:48:32 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 31 18:48:33 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Aug 31 18:48:36 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Aug 31 18:48:36 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand update Aug 31 18:48:36 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 18:48:37 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:37 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:40 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 18:48:42 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:42 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:43 volumio nmbd[743]: [2026/08/31 18:48:43.653842, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 31 18:48:43 volumio nmbd[743]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Aug 31 18:48:44 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 18:48:47 volumio volumio[874]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Aug 31 18:48:47 volumio volumio[874]: info: Discovery: Restarting Browsing Aug 31 18:48:48 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Aug 31 18:48:48 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Aug 31 18:48:48 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 18:48:49 volumio volumio[874]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 18:48:49 volumio volumio[874]: Error: getaddrinfo -3007 Aug 31 18:48:49 volumio volumio[874]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Aug 31 18:48:49 volumio volumio[874]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Aug 31 18:48:49 volumio volumio[874]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Aug 31 18:48:49 volumio volumio[874]: code: -3007, Aug 31 18:48:49 volumio volumio[874]: errno: -3007, Aug 31 18:48:49 volumio volumio[874]: syscall: 'getaddrinfo' Aug 31 18:48:49 volumio volumio[874]: } Aug 31 18:48:49 volumio volumio[874]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 18:48:49 volumio sudo[5916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-31 18:47 Aug 31 18:48:49 volumio sudo[5916]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"