Jan 27 13:26:15 volumio go-librespot[8409]: time="2026-01-27T13:26:15+03:00" level=trace msg="sent dealer ping" Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 27 13:26:16 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 27 13:26:16 volumio go-librespot[8409]: time="2026-01-27T13:26:16+03:00" level=trace msg="received dealer pong" Jan 27 13:26:27 volumio volumio[1328]: info: Jan 27 13:26:27 volumio volumio[1328]: ---------------------------- MPD announces system playlist update Jan 27 13:26:27 volumio volumio[1328]: info: Ignoring MPD Status Update Jan 27 13:26:27 volumio volumio[1328]: info: Jan 27 13:26:27 volumio volumio[1328]: ---------------------------- MPD announces state update: player Jan 27 13:26:27 volumio volumio[1328]: info: ControllerMpd::getState Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand status Jan 27 13:26:27 volumio volumio[1328]: info: Jan 27 13:26:27 volumio volumio[1328]: ---------------------------- MPD announces system playlist update Jan 27 13:26:27 volumio volumio[1328]: info: Ignoring MPD Status Update Jan 27 13:26:27 volumio volumio[1328]: info: Jan 27 13:26:27 volumio volumio[1328]: ---------------------------- MPD announces state update: player Jan 27 13:26:27 volumio volumio[1328]: info: ControllerMpd::getState Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand status Jan 27 13:26:27 volumio volumio[1328]: info: ------------------------------ 1ms Jan 27 13:26:27 volumio volumio[1328]: info: sendMpdCommand status took 1 milliseconds Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::parseState Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 13:26:27 volumio volumio[1328]: info: ------------------------------ 1ms Jan 27 13:26:27 volumio volumio[1328]: info: sendMpdCommand status took 0 milliseconds Jan 27 13:26:27 volumio volumio[1328]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::parseState Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::parseTrackInfo Jan 27 13:26:27 volumio volumio[1328]: info: ControllerMpd::pushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreCommandRouter::servicePushState Jan 27 13:26:27 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:27 volumio volumio[1328]: verbose: STATE SERVICE {"status":"play","position":0,"seek":943938,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Relax - Entspannt durch den Tag","artist":"Absolut relax","album":null,"uri":"https://absolut-relax.live-sm.absolutradio.de/absolut-relax/stream/mp3?aggregator=TuneIn","trackType":""} Jan 27 13:26:27 volumio volumio[1328]: verbose: CURRENT POSITION 0 Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::syncState stateService play Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::syncState currentStatus play Jan 27 13:26:27 volumio volumio[1328]: info: Received an update from plugin. extracting info from payload Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::pushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 13:26:27 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::pushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState Jan 27 13:26:27 volumio volumio[1328]: info: ------------------------------ 4ms Jan 27 13:26:27 volumio volumio[1328]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 27 13:26:27 volumio volumio[1328]: verbose: ControllerMpd::parseTrackInfo Jan 27 13:26:27 volumio volumio[1328]: info: ControllerMpd::pushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreCommandRouter::servicePushState Jan 27 13:26:27 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:27 volumio volumio[1328]: verbose: STATE SERVICE {"status":"play","position":0,"seek":943938,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Relax - Entspannt durch den Tag","artist":"Absolut relax","album":null,"uri":"https://absolut-relax.live-sm.absolutradio.de/absolut-relax/stream/mp3?aggregator=TuneIn","trackType":""} Jan 27 13:26:27 volumio volumio[1328]: verbose: CURRENT POSITION 0 Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::syncState stateService play Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::syncState currentStatus play Jan 27 13:26:27 volumio volumio[1328]: info: Received an update from plugin. extracting info from payload Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::pushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreStateMachine::pushState Jan 27 13:26:27 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState Jan 27 13:26:27 volumio volumio[1328]: info: ------------------------------ 9ms Jan 27 13:26:32 volumio volumio[1328]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 13:26:32 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 13:26:32 volumio sudo[11200]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 27 13:26:32 volumio sudo[11200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 13:26:32 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 27 13:26:32 volumio sudo[11198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 27 13:26:32 volumio sudo[11198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 13:26:32 volumio sudo[11198]: pam_unix(sudo:session): session closed for user root Jan 27 13:26:32 volumio volumio[1328]: info: MPD Permissions set Jan 27 13:26:32 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 27 13:26:32 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 27 13:26:32 volumio systemd[1]: mpd.service: Consumed 5.863s CPU time. Jan 27 13:26:32 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 27 13:26:32 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 27 13:26:32 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 27 13:26:32 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 27 13:26:32 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 27 13:26:32 volumio sudo[11211]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 27 13:26:32 volumio sudo[11211]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 13:26:32 volumio sudo[11211]: pam_unix(sudo:session): session closed for user root Jan 27 13:26:32 volumio mpd[11214]: 2026-01-27T13:26:32 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 27 13:26:32 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 27 13:26:32 volumio sudo[11200]: pam_unix(sudo:session): session closed for user root Jan 27 13:26:32 volumio volumio[1328]: error: updateQueue error: null Jan 27 13:26:40 volumio volumio[1328]: info: CoreCommandRouter::volumioStop Jan 27 13:26:40 volumio volumio[1328]: info: CoreStateMachine::stop Jan 27 13:26:40 volumio volumio[1328]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 13:26:40 volumio volumio[1328]: info: CoreStateMachine::stPlaybackTimer Jan 27 13:26:40 volumio volumio[1328]: info: CoreStateMachine::updateTrackBlock Jan 27 13:26:40 volumio volumio[1328]: info: CorePlayQueue::getTrackBlock Jan 27 13:26:40 volumio volumio[1328]: info: CoreStateMachine::pushState Jan 27 13:26:40 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:40 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 13:26:40 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState Jan 27 13:26:40 volumio volumio[1328]: info: CoreStateMachine::serviceStop Jan 27 13:26:40 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:40 volumio volumio[1328]: info: CoreCommandRouter::serviceStop Jan 27 13:26:40 volumio volumio[1328]: info: [1769509600497] ControllerWebradio::stop Jan 27 13:26:40 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 13:26:40 volumio volumio[1328]: info: sendMpdCommand stop took 2 milliseconds Jan 27 13:26:40 volumio volumio[1328]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 27 13:26:41 volumio volumio[1328]: info: CoreCommandRouter::volumioPlay Jan 27 13:26:41 volumio volumio[1328]: info: CoreStateMachine::play index undefined Jan 27 13:26:41 volumio volumio[1328]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 13:26:41 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:41 volumio volumio[1328]: info: CoreStateMachine::startPlaybackTimer Jan 27 13:26:41 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:41 volumio volumio[1328]: info: [1769509601824] ControllerWebradio::clearAddPlayTrack Jan 27 13:26:41 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand stop Jan 27 13:26:41 volumio volumio[1328]: info: sendMpdCommand stop took 0 milliseconds Jan 27 13:26:41 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand clear Jan 27 13:26:41 volumio volumio[1328]: info: Jan 27 13:26:41 volumio volumio[1328]: ---------------------------- MPD announces system playlist update Jan 27 13:26:41 volumio volumio[1328]: info: Ignoring MPD Status Update Jan 27 13:26:41 volumio volumio[1328]: info: sendMpdCommand clear took 0 milliseconds Jan 27 13:26:41 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-relax.live-sm.absolutradio.de/absolut-relax/stream/mp3?aggregator=TuneIn" Jan 27 13:26:41 volumio volumio[1328]: error: updateQueue error: null Jan 27 13:26:41 volumio volumio[1328]: info: ------------------------------ 1ms Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-relax.live-sm.absolutradio.de/absolut-relax/stream/mp3?aggregator=TuneIn" Jan 27 13:26:43 volumio volumio[1328]: info: sendMpdCommand add "https://absolut-relax.live-sm.absolutradio.de/absolut-relax/stream/mp3?aggregator=TuneIn" took 0 milliseconds Jan 27 13:26:43 volumio volumio[1328]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand play Jan 27 13:26:43 volumio volumio[1328]: info: Jan 27 13:26:43 volumio volumio[1328]: ---------------------------- MPD announces system playlist update Jan 27 13:26:43 volumio volumio[1328]: info: Ignoring MPD Status Update Jan 27 13:26:43 volumio volumio[1328]: info: sendMpdCommand play took 0 milliseconds Jan 27 13:26:43 volumio volumio[1328]: info: ------------------------------ 0ms Jan 27 13:26:43 volumio volumio[1328]: info: Jan 27 13:26:43 volumio volumio[1328]: ---------------------------- MPD announces state update: player Jan 27 13:26:43 volumio volumio[1328]: info: ControllerMpd::getState Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand status Jan 27 13:26:43 volumio volumio[1328]: info: Jan 27 13:26:43 volumio volumio[1328]: ---------------------------- MPD announces system playlist update Jan 27 13:26:43 volumio volumio[1328]: info: Ignoring MPD Status Update Jan 27 13:26:43 volumio volumio[1328]: info: Jan 27 13:26:43 volumio volumio[1328]: ---------------------------- MPD announces state update: player Jan 27 13:26:43 volumio volumio[1328]: info: sendMpdCommand status took 17 milliseconds Jan 27 13:26:43 volumio volumio[1328]: info: ControllerMpd::getState Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand status Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::parseState Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 13:26:43 volumio volumio[1328]: info: ------------------------------ 0ms Jan 27 13:26:43 volumio volumio[1328]: info: sendMpdCommand status took 1 milliseconds Jan 27 13:26:43 volumio volumio[1328]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::parseState Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::parseTrackInfo Jan 27 13:26:43 volumio volumio[1328]: info: ControllerMpd::pushState Jan 27 13:26:43 volumio volumio[1328]: info: CoreCommandRouter::servicePushState Jan 27 13:26:43 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:43 volumio volumio[1328]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"BANGLES - MANIC MONDAY","artist":"Absolut relax","album":null,"uri":"https://absolut-relax.live-sm.absolutradio.de/absolut-relax/stream/mp3?aggregator=TuneIn","trackType":""} Jan 27 13:26:43 volumio volumio[1328]: verbose: CURRENT POSITION 0 Jan 27 13:26:43 volumio volumio[1328]: info: CoreStateMachine::syncState stateService play Jan 27 13:26:43 volumio volumio[1328]: info: CoreStateMachine::syncState currentStatus stop Jan 27 13:26:43 volumio volumio[1328]: info: ------------------------------ 21ms Jan 27 13:26:43 volumio volumio[1328]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 27 13:26:43 volumio volumio[1328]: verbose: ControllerMpd::parseTrackInfo Jan 27 13:26:43 volumio volumio[1328]: info: ControllerMpd::pushState Jan 27 13:26:43 volumio volumio[1328]: info: CoreCommandRouter::servicePushState Jan 27 13:26:43 volumio volumio[1328]: info: CorePlayQueue::getTrack 0 Jan 27 13:26:43 volumio volumio[1328]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1007,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"BANGLES - MANIC MONDAY","artist":"Absolut relax","album":null,"uri":"https://absolut-relax.live-sm.absolutradio.de/absolut-relax/stream/mp3?aggregator=TuneIn","trackType":""} Jan 27 13:26:43 volumio volumio[1328]: verbose: CURRENT POSITION 0 Jan 27 13:26:43 volumio volumio[1328]: info: CoreStateMachine::syncState stateService play Jan 27 13:26:43 volumio volumio[1328]: info: CoreStateMachine::syncState currentStatus play Jan 27 13:26:43 volumio volumio[1328]: info: Received an update from plugin. extracting info from payload Jan 27 13:26:43 volumio volumio[1328]: info: CoreStateMachine::pushState Jan 27 13:26:43 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 13:26:43 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState Jan 27 13:26:43 volumio volumio[1328]: info: CoreStateMachine::pushState Jan 27 13:26:43 volumio volumio[1328]: info: CoreCommandRouter::volumioPushState Jan 27 13:26:43 volumio volumio[1328]: info: ------------------------------ 4ms Jan 27 13:26:45 volumio go-librespot[8409]: time="2026-01-27T13:26:45+03:00" level=trace msg="sent dealer ping" Jan 27 13:26:46 volumio go-librespot[8409]: time="2026-01-27T13:26:46+03:00" level=trace msg="received dealer pong" Jan 27 13:26:52 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 13:26:52 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 27 13:26:56 volumio volumio[1328]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 13:26:56 volumio volumio[1328]: info: AutoStart - getUIConfig Jan 27 13:27:03 volumio volumio[1328]: info: CALLMETHOD: system_controller autostart saveOptions [object Object] Jan 27 13:27:03 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: autostart , saveOptions Jan 27 13:27:03 volumio volumio[1328]: info: AutoStart - saving playback settings Jan 27 13:27:03 volumio volumio[1328]: info: AutoStart - playback settings saved Jan 27 13:27:15 volumio go-librespot[8409]: time="2026-01-27T13:27:15+03:00" level=trace msg="sent dealer ping" Jan 27 13:27:16 volumio go-librespot[8409]: time="2026-01-27T13:27:16+03:00" level=trace msg="received dealer pong" Jan 27 13:27:16 volumio go-librespot[8409]: time="2026-01-27T13:27:16+03:00" level=trace msg="received accesspoint ping" Jan 27 13:27:16 volumio go-librespot[8409]: time="2026-01-27T13:27:16+03:00" level=trace msg="received accesspoint pong ack" Jan 27 13:27:37 volumio nmbd[2342]: [2026/01/27 13:27:37.015515, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jan 27 13:27:37 volumio nmbd[2342]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.22 for name WORKGROUP<1d>. Jan 27 13:27:37 volumio nmbd[2342]: This response was from IP 192.168.1.25, reporting an IP address of 192.168.1.25. Jan 27 13:27:45 volumio go-librespot[8409]: time="2026-01-27T13:27:45+03:00" level=trace msg="sent dealer ping" Jan 27 13:27:46 volumio go-librespot[8409]: time="2026-01-27T13:27:46+03:00" level=trace msg="received dealer pong" Jan 27 13:27:46 volumio sshd[11314]: Accepted password for volumio from 192.168.1.19 port 53877 ssh2 Jan 27 13:27:46 volumio sshd[11314]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Jan 27 13:27:46 volumio systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Jan 27 13:27:46 volumio systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Jan 27 13:27:46 volumio systemd-logind[979]: New session 1 of user volumio. Jan 27 13:27:46 volumio systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Jan 27 13:27:46 volumio systemd[1]: Starting user@1000.service - User Manager for UID 1000... Jan 27 13:27:46 volumio (systemd)[11332]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Jan 27 13:27:46 volumio systemd[11332]: Queued start job for default target default.target. Jan 27 13:27:46 volumio systemd[11332]: Created slice app.slice - User Application Slice. Jan 27 13:27:46 volumio systemd[11332]: Reached target paths.target - Paths. Jan 27 13:27:46 volumio systemd[11332]: Reached target timers.target - Timers. Jan 27 13:27:46 volumio systemd[11332]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 27 13:27:46 volumio systemd[11332]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Jan 27 13:27:46 volumio systemd[11332]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Jan 27 13:27:46 volumio systemd[11332]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Jan 27 13:27:46 volumio systemd[11332]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Jan 27 13:27:46 volumio systemd[11332]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Jan 27 13:27:46 volumio systemd[11332]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 27 13:27:46 volumio systemd[11332]: Reached target sockets.target - Sockets. Jan 27 13:27:46 volumio systemd[11332]: Reached target basic.target - Basic System. Jan 27 13:27:46 volumio systemd[1]: Started user@1000.service - User Manager for UID 1000. Jan 27 13:27:46 volumio systemd[11332]: Started mpris-proxy.service - Bluetooth mpris proxy. Jan 27 13:27:46 volumio systemd[11332]: Reached target default.target - Main User Target. Jan 27 13:27:46 volumio systemd[11332]: Startup finished in 203ms. Jan 27 13:27:46 volumio systemd[1]: Started session-1.scope - Session 1 of User volumio. Jan 27 13:27:46 volumio systemd[11332]: Created slice session.slice - User Core Session Slice. Jan 27 13:27:46 volumio systemd[11332]: Starting dbus.service - D-Bus User Message Bus... Jan 27 13:27:47 volumio systemd[11332]: Started dbus.service - D-Bus User Message Bus. Jan 27 13:27:47 volumio sshd[11314]: pam_env(sshd:session): deprecated reading of user environment enabled Jan 27 13:27:54 volumio volumio[1328]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 13:27:54 volumio volumio[1328]: Error Jan 27 13:27:54 volumio volumio[1328]: at /volumio/app/plugins/music_service/webradio/index.js:427:31 Jan 27 13:27:54 volumio volumio[1328]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:444:15) Jan 27 13:27:54 volumio volumio[1328]: at self.callback (/volumio/node_modules/request/request.js:185:22) Jan 27 13:27:54 volumio volumio[1328]: at Request.emit (node:events:514:28) Jan 27 13:27:54 volumio volumio[1328]: at Request.onRequestError (/volumio/node_modules/request/request.js:877:8) Jan 27 13:27:54 volumio volumio[1328]: at ClientRequest.emit (node:events:514:28) Jan 27 13:27:54 volumio volumio[1328]: at Socket.socketErrorListener (node:_http_client:495:9) Jan 27 13:27:54 volumio volumio[1328]: at Socket.emit (node:events:514:28) Jan 27 13:27:54 volumio volumio[1328]: at emitErrorNT (node:internal/streams/destroy:151:8) Jan 27 13:27:54 volumio volumio[1328]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Jan 27 13:27:54 volumio volumio[1328]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Jan 27 13:27:54 volumio volumio[1328]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 13:27:54 volumio sudo[11392]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-27 13:26' Jan 27 13:27:54 volumio sudo[11392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"