-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2026-02-07 17:57:05 CET. -- Feb 07 17:56:20 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:20 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Prefetching next song Feb 07 17:56:20 luxman-volumio volumio[1136]: info: DOING PREFETCH IN MPD Feb 07 17:56:20 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand add "USB/Foto_SSD/Alan Parsons Project The/Pyramid - 1984/02 What Goes Up.mp3" Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Feb 07 17:56:20 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: sendMpdCommand add "USB/Foto_SSD/Alan Parsons Project The/Pyramid - 1984/02 What Goes Up.mp3" took 2 milliseconds Feb 07 17:56:20 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Feb 07 17:56:20 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Feb 07 17:56:20 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Feb 07 17:56:20 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:20 luxman-volumio volumio[1136]: info: ------------------------------ 6ms Feb 07 17:56:20 luxman-volumio volumio[1136]: info: sendMpdCommand consume 1 took 4 milliseconds Feb 07 17:56:20 luxman-volumio volumio[1136]: info: ------------------------------ 4ms Feb 07 17:56:20 luxman-volumio volumio[1136]: info: ------------------------------ 4ms Feb 07 17:56:20 luxman-volumio volumio[1136]: info: ------------------------------ 3ms Feb 07 17:56:24 luxman-volumio go-librespot[2078]: time="2026-02-07T17:56:24+01:00" level=trace msg="sent dealer ping" Feb 07 17:56:24 luxman-volumio go-librespot[2078]: time="2026-02-07T17:56:24+01:00" level=trace msg="received dealer pong" Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::startPlaybackTimer Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces state update: player Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::getState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces state update: player Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::getState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 6ms Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand status took 3 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 3ms Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand status took 2 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces state update: player Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::getState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces system playlist update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Ignoring MPD Status Update Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Feb 07 17:56:25 luxman-volumio volumio[1136]: ---------------------------- MPD announces state update: player Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::getState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand status Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 5ms Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand status took 5 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 4ms Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand status took 3 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseTrackInfo Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseTrackInfo Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseState Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::servicePushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":211,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"What Goes Up...","artist":"Alan Parsons Project The","album":"Pyramid","uri":"USB/Foto_SSD/Alan Parsons Project The/Pyramid - 1984/02 What Goes Up.mp3","trackType":"mp3"} Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: CURRENT POSITION 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState stateService play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState currentStatus play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Received an update from plugin. extracting info from payload Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::servicePushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":211,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"What Goes Up...","artist":"Alan Parsons Project The","album":"Pyramid","uri":"USB/Foto_SSD/Alan Parsons Project The/Pyramid - 1984/02 What Goes Up.mp3","trackType":"mp3"} Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: CURRENT POSITION 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState stateService play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState currentStatus play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Received an update from plugin. extracting info from payload Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 47ms Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 47ms Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand playlistinfo took 41 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: info: sendMpdCommand playlistinfo took 42 milliseconds Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseTrackInfo Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: ControllerMpd::parseTrackInfo Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::servicePushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":211,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"What Goes Up...","artist":"Alan Parsons Project The","album":"Pyramid","uri":"USB/Foto_SSD/Alan Parsons Project The/Pyramid - 1984/02 What Goes Up.mp3","trackType":"mp3"} Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: CURRENT POSITION 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState stateService play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState currentStatus play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Received an update from plugin. extracting info from payload Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ControllerMpd::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::servicePushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":211,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"What Goes Up...","artist":"Alan Parsons Project The","album":"Pyramid","uri":"USB/Foto_SSD/Alan Parsons Project The/Pyramid - 1984/02 What Goes Up.mp3","trackType":"mp3"} Feb 07 17:56:25 luxman-volumio volumio[1136]: verbose: CURRENT POSITION 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState stateService play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::syncState currentStatus play Feb 07 17:56:25 luxman-volumio volumio[1136]: info: Received an update from plugin. extracting info from payload Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 80ms Feb 07 17:56:25 luxman-volumio volumio[1136]: info: ------------------------------ 79ms Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreStateMachine::pushState Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CorePlayQueue::getTrack 1 Feb 07 17:56:25 luxman-volumio volumio[1136]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: SPOTIFY VOLUME 90 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: VOLUMIO VOLUME 91 Feb 07 17:56:25 luxman-volumio volumio[1136]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 07 17:56:29 luxman-volumio volumiologrotate[589]: ls: cannot access '/var/log/samba/log.wb-LUXMAN': No such file or directory Feb 07 17:56:29 luxman-volumio volumiologrotate[589]: ls: cannot access 'VOLUMIO': No such file or directory Feb 07 17:56:34 luxman-volumio volumio[1136]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:56:34 luxman-volumio volumio[1136]: Error: connect EHOSTUNREACH 199.232.174.79:80 Feb 07 17:56:34 luxman-volumio volumio[1136]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 07 17:56:34 luxman-volumio volumio[1136]: errno: -113, Feb 07 17:56:34 luxman-volumio volumio[1136]: code: 'EHOSTUNREACH', Feb 07 17:56:34 luxman-volumio volumio[1136]: syscall: 'connect', Feb 07 17:56:34 luxman-volumio volumio[1136]: address: '199.232.174.79', Feb 07 17:56:34 luxman-volumio volumio[1136]: port: 80 Feb 07 17:56:34 luxman-volumio volumio[1136]: } Feb 07 17:56:34 luxman-volumio volumio[1136]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:56:35 luxman-volumio sudo[9558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 17:55 Feb 07 17:56:35 luxman-volumio sudo[9558]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:35 luxman-volumio sudo[9558]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:35 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:35] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 17:56:35 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:35] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 17:56:35 luxman-volumio go-librespot[2078]: time="2026-02-07T17:56:35+01:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Feb 07 17:56:35 luxman-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:35 luxman-volumio systemd[1]: media-Foto_SSD.mount: Succeeded. Feb 07 17:56:35 luxman-volumio ntfs-3g[2935]: Unmounting /dev/sda1 (Foto SSD) Feb 07 17:56:35 luxman-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 17:56:35 luxman-volumio systemd[1]: Started dynamicswap service. Feb 07 17:56:35 luxman-volumio systemd[1]: dynamicswap.service: Succeeded. Feb 07 17:56:36 luxman-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 17:56:36 luxman-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Feb 07 17:56:36 luxman-volumio systemd[1]: Stopped Volumio Backend Module. Feb 07 17:56:36 luxman-volumio systemd[1]: Started Volumio Backend Module. Feb 07 17:56:36 luxman-volumio systemd[1]: Started dynamicswap service. Feb 07 17:56:36 luxman-volumio systemd[1]: dynamicswap.service: Succeeded. Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ------------------------------------------- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ----- Volumio3 ---- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ------------------------------------------- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ----- System startup ---- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ------------------------------------------- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: MYVOLUMIO Environment detected Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Plugin folders cleanup Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning into folder /volumio/app/plugins/ Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category audio_interface Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category miscellanea Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category music_service Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category plugins.json Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category system_controller Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category user_interface Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning into folder /data/plugins/ Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category audio_interface Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category music_service Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category system_controller Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Scanning category user_interface Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Plugin folders cleanup completed Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ------------------------------------------- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ----- Core plugins startup ---- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: ------------------------------------------- Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Adding plugin upnp to MyMusic Plugins Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Loading plugins from folder /data/plugins/ Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Loading plugin "system"... Feb 07 17:56:37 luxman-volumio volumio[9581]: info: Loading plugin "appearance"... Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Loading plugin "network"... Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Refreshing Cached IP Addresses Feb 07 17:56:38 luxman-volumio sudo[9612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Loading plugin "services"... Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Loading plugin "alsa_controller"... Feb 07 17:56:38 luxman-volumio sudo[9612]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:38 luxman-volumio sudo[9616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 17:56:38 luxman-volumio sudo[9623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 17:56:38 luxman-volumio sudo[9612]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:38 luxman-volumio sudo[9616]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:38 luxman-volumio sudo[9623]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:38 luxman-volumio sudo[9616]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:38 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Loading plugin "wizard"... Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Loading plugin "networkfs"... Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Starting Udev Watcher for removable devices Feb 07 17:56:38 luxman-volumio sudo[9664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.50.99/w-usb/%23 Musik /mnt/NAS/Musik_på_NAS Feb 07 17:56:38 luxman-volumio sudo[9664]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Ignoring mount for partition: BOOT Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Ignoring mount for partition: volumio Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Ignoring mount for partition: volumio_data Feb 07 17:56:38 luxman-volumio volumio[9581]: info: Mounting Device Foto_SSD Feb 07 17:56:38 luxman-volumio sudo[9680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Foto_SSD -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:38 luxman-volumio sudo[9664]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:38 luxman-volumio kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE Feb 07 17:56:38 luxman-volumio kernel: CIFS VFS: Send error in SessSetup = -13 Feb 07 17:56:38 luxman-volumio kernel: CIFS VFS: cifs_mount failed w/return code = -13 Feb 07 17:56:38 luxman-volumio sudo[9680]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:38 luxman-volumio sudo[9623]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:39 luxman-volumio ntfs-3g[9693]: Version 2017.3.23AR.3 integrated FUSE 28 Feb 07 17:56:39 luxman-volumio sudo[9680]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:39 luxman-volumio ntfs-3g[9693]: Mounted /dev/sda1 (Read-Write, label "Foto SSD", NTFS 3.1) Feb 07 17:56:39 luxman-volumio ntfs-3g[9693]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:39 luxman-volumio ntfs-3g[9693]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Feb 07 17:56:39 luxman-volumio ntfs-3g[9693]: Global ownership and permissions enforced, configuration type 7 Feb 07 17:56:39 luxman-volumio ntfs-3g[9693]: Unmounting /dev/sda1 (Foto SSD) Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Mounting Device 1F17-3DEC Feb 07 17:56:39 luxman-volumio sudo[9701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/1F17-3DEC -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:39 luxman-volumio sudo[9701]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:39 luxman-volumio sudo[9701]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:39 luxman-volumio volumio[9581]: mount: /media/1F17-3DEC: /dev/sda2 already mounted on /media/1F17-3DEC. Feb 07 17:56:39 luxman-volumio volumio[9581]: error: Failed to mount 1F17-3DEC: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/1F17-3DEC" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:39 luxman-volumio volumio[9581]: mount: /media/1F17-3DEC: /dev/sda2 already mounted on /media/1F17-3DEC. Feb 07 17:56:39 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "volumio_command_line_client"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "upnp"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: [1770483399382] Starting Upmpd Daemon Feb 07 17:56:39 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "my_music"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "mpd"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "upnp_browser"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Starting UPNP Browser Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "alarm-clock"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "airplay_emulation"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Starting Shairport Sync Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "last_100"... Feb 07 17:56:39 luxman-volumio volumio[9581]: info: Loading plugin "webradio"... Feb 07 17:56:40 luxman-volumio volumio[9581]: info: Loading plugin "i2s_dacs"... Feb 07 17:56:40 luxman-volumio volumio[9581]: info: I2S DAC not set, start Auto-detection Feb 07 17:56:40 luxman-volumio volumio[9581]: info: Loading plugin "volumiodiscovery"... Feb 07 17:56:40 luxman-volumio volumio[9581]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:40 luxman-volumio volumio[9581]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:40 luxman-volumio volumio[9581]: *** WARNING *** For more information see Feb 07 17:56:40 luxman-volumio volumio[9581]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:40 luxman-volumio volumio[9581]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:40 luxman-volumio node[9581]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:40 luxman-volumio volumio[9581]: *** WARNING *** For more information see Feb 07 17:56:40 luxman-volumio node[9581]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:40 luxman-volumio node[9581]: *** WARNING *** For more information see Feb 07 17:56:40 luxman-volumio node[9581]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:40 luxman-volumio node[9581]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:40 luxman-volumio node[9581]: *** WARNING *** For more information see Feb 07 17:56:40 luxman-volumio volumio[9581]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 17:56:40 luxman-volumio volumio[9581]: info: Discovery: Started advertising with name: LUXMAN Volumio Feb 07 17:56:40 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:40 luxman-volumio volumio[9581]: info: Loading plugin "spop"... Feb 07 17:56:40 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:40] [connect] Successful connection Feb 07 17:56:40 luxman-volumio volumio[9581]: info: Loading plugin "now_playing"... Feb 07 17:56:41 luxman-volumio volumio[9581]: info: Loading plugin "outputs"... Feb 07 17:56:41 luxman-volumio volumio[9581]: info: Loading plugin "albumart"... Feb 07 17:56:41 luxman-volumio volumio[9581]: info: Plugin example_plugin is not enabled Feb 07 17:56:41 luxman-volumio volumio[9581]: info: Loading plugin "inputs"... Feb 07 17:56:41 luxman-volumio volumio[9581]: info: Loading plugin "updater_comm"... Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Plugin mpdemulation is not enabled Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Loading plugin "rest_api"... Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Loading plugin "websocket"... Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Starting Socket.io Server version 2.3.0 Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Loading plugin "fusiondsp"... Feb 07 17:56:42 luxman-volumio volumio[9581]: Forking 3 albumart workers Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Applying required configuration parameters for plugin fusiondsp Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Loading plugin "backup_restore"... Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Applying required configuration parameters for plugin backup_restore Feb 07 17:56:42 luxman-volumio volumio[9581]: info: Loading i18n strings for locale sv Feb 07 17:56:42 luxman-volumio volumio[9581]: Updating browse sources language Feb 07 17:56:42 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:42 luxman-volumio volumio[9581]: Starting albumart workers Feb 07 17:56:42 luxman-volumio volumio[9581]: Starting albumart workers Feb 07 17:56:43 luxman-volumio volumio[9581]: Starting albumart workers Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::initPlayerControls Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: Express server listening on port 3000 Feb 07 17:56:43 luxman-volumio volumio[9581]: [Metrics] WebUI: 6s 148.11ms Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::resetVolumioState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::getcurrentVolume Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Completed loading Core Plugins Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Preparing to generate the ALSA configuration file Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Volumio Network Manager: Network status updated: 2 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Cannot mount NAS Musik_på_NAS at system boot, trial number 1 ,retrying in 5 seconds Feb 07 17:56:43 luxman-volumio volumio[9581]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Reading ALSA contributions from plugins. Feb 07 17:56:43 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 1 Feb 07 17:56:43 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 192.168.50.79:3000 from 192.168.50.239 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Feb 07 17:56:43 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 3 Feb 07 17:56:43 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:43] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770483400 101 Feb 07 17:56:43 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Discovery: Getting this device information Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Scanning new location : "USB/Foto_SSD" Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Reloading queue from file Feb 07 17:56:43 luxman-volumio volumio[9581]: info: VolumeController:: Volume=89 Mute =false Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::pushState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::updateTrackBlock Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrackBlock Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Setting Device type: Tinkerboard Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::setRepeat null single undefined Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::pushState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::setRandom false Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::pushState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:43 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 192.168.50.79:3000 from 192.168.50.239 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Discovery: Getting this device information Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 17:56:43 luxman-volumio volumio[9581]: info: VolumeController:: Volume=89 Mute =false Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreStateMachine::pushState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Asound.conf file unchanged, so no further update is needed Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Output device has changed, restarting MPD Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Output device has changed, restarting Shairport Sync Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:43 luxman-volumio sudo[9782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:56:43 luxman-volumio sudo[9782]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:43 luxman-volumio sudo[9784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:56:43 luxman-volumio sudo[9782]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:43 luxman-volumio sudo[9784]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:43 luxman-volumio volumio[9581]: info: ___________ START PLUGINS ___________ Feb 07 17:56:43 luxman-volumio volumio[9581]: info: ControllerMpd::onStart: Initializing MPD Feb 07 17:56:43 luxman-volumio volumio[9581]: info: Creating MPD Configuration file Feb 07 17:56:43 luxman-volumio systemd[1]: Stopping Music Player Daemon... Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:56:43 luxman-volumio volumio[9581]: info: [1770483403953] CoreMusicLibrary::Adding element Mediaservrar Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:43 luxman-volumio sudo[9802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:56:43 luxman-volumio volumio[9581]: info: UPNP Browser: Client initialized successfully Feb 07 17:56:43 luxman-volumio sudo[9802]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:43 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:43 luxman-volumio sudo[9805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:56:43 luxman-volumio sudo[9802]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:43 luxman-volumio sudo[9805]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:56:44 luxman-volumio volumio[9581]: info: [1770483404041] CoreMusicLibrary::Adding element Last_100 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:56:44 luxman-volumio volumio[9581]: info: [1770483404043] CoreMusicLibrary::Adding element Webradio Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Initializing BBC Radios Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Creating Spotify config file Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: [now-playing] ConfigUpdater: config is up to date. Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Loading i18n strings for locale sv Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: FusionDsp - mixtype--------------------- Hardware Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Volumio Calling Home Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Preparing to generate the ALSA configuration file Feb 07 17:56:44 luxman-volumio volumio[9581]: info: [now-playing] App is listening on port 4004. Feb 07 17:56:44 luxman-volumio volumio[9581]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Feb 07 17:56:44 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 192.168.50.79 from 192.168.50.239 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Discovery: adding 10a99ae7-142c-4cfb-b085-cd51c47c9dd8 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Discovery: Found device LUXMAN Volumio Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Reading ALSA contributions from plugins. Feb 07 17:56:44 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 192.168.50.79 from 192.168.50.239 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 07 17:56:44 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 192.168.50.79 from 192.168.50.239 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: MPD Permissions set Feb 07 17:56:44 luxman-volumio volumio[9581]: info: MPD Permissions set Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Spotify config file written Feb 07 17:56:44 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio sudo[9838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 07 17:56:44 luxman-volumio sudo[9838]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio systemd[1]: Stopping go-librespot Daemon... Feb 07 17:56:44 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Feb 07 17:56:44 luxman-volumio systemd[1]: go-librespot-daemon.service: Succeeded. Feb 07 17:56:44 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:56:44 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:56:44 luxman-volumio sudo[9838]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:44 luxman-volumio go-librespot[9854]: go-librespot daemon starting... Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: No need to fix Spotify hosts Feb 07 17:56:44 luxman-volumio go-librespot[9854]: time="2026-02-07T17:56:44+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:56:44 luxman-volumio go-librespot[9854]: time="2026-02-07T17:56:44+01:00" level=debug msg="app state loaded" Feb 07 17:56:44 luxman-volumio go-librespot[9854]: time="2026-02-07T17:56:44+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:56:44 luxman-volumio go-librespot[9854]: time="2026-02-07T17:56:44+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:56:44 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:44 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Starting Shairport Sync Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Starting Shairport Sync Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Starting Shairport Sync Feb 07 17:56:44 luxman-volumio sudo[9867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:44 luxman-volumio sudo[9869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:44 luxman-volumio sudo[9867]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:44 luxman-volumio sudo[9869]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:44 luxman-volumio sudo[9876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:44 luxman-volumio sudo[9876]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:44 luxman-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 07 17:56:44 luxman-volumio systemd[1]: shairport-sync.service: Succeeded. Feb 07 17:56:44 luxman-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:44 luxman-volumio volumio[9581]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 9 Feb 07 17:56:44 luxman-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:44 luxman-volumio sudo[9869]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:44 luxman-volumio sudo[9867]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Asound.conf file unchanged, so no further update is needed Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Output device has changed, restarting MPD Feb 07 17:56:44 luxman-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 07 17:56:44 luxman-volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 07 17:56:44 luxman-volumio systemd[1]: shairport-sync.service: Succeeded. Feb 07 17:56:44 luxman-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:44 luxman-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Output device has changed, restarting Shairport Sync Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:44 luxman-volumio sudo[9876]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:44 luxman-volumio sudo[9895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:56:44 luxman-volumio sudo[9895]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:44 luxman-volumio sudo[9895]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:44 luxman-volumio sudo[9901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:56:44 luxman-volumio volumio[9581]: info: New Spotify access tokenBQBPhnpMJb... Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Spotify credentials grant success - running version from March 24, 2019 Feb 07 17:56:44 luxman-volumio sudo[9901]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 17:56:44 luxman-volumio volumio[9581]: info: MPD Permissions set Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Shairport-Sync Started Feb 07 17:56:44 luxman-volumio volumio[9581]: Error adding Membership: Error: addMembership EINVAL Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Shairport-Sync Started Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Shairport-Sync Started Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetVisibleSources Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Received Get System Info Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Discovery: Getting this device information Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Listing playlists Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:56:44 luxman-volumio volumio[9581]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:44 luxman-volumio volumio[9581]: error: Failed to retrieve user informations: Error: connect EHOSTUNREACH 35.186.224.24:443 Feb 07 17:56:44 luxman-volumio volumio[9581]: error: Spotify credentials failed to read user data: Feb 07 17:56:44 luxman-volumio volumio[9581]: info: An error occurred while initializing Spotify Browsing facility: Feb 07 17:56:44 luxman-volumio volumio[9581]: info: Starting Shairport Sync Feb 07 17:56:44 luxman-volumio systemd[1]: mpd.service: Succeeded. Feb 07 17:56:44 luxman-volumio systemd[1]: Stopped Music Player Daemon. Feb 07 17:56:44 luxman-volumio systemd[1]: Starting Music Player Daemon... Feb 07 17:56:45 luxman-volumio volumio[9581]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:56:45 luxman-volumio sudo[9929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:45 luxman-volumio volumio[9581]: Error: connect EHOSTUNREACH 199.232.174.53:443 Feb 07 17:56:45 luxman-volumio volumio[9581]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 07 17:56:45 luxman-volumio volumio[9581]: errno: -113, Feb 07 17:56:45 luxman-volumio volumio[9581]: code: 'EHOSTUNREACH', Feb 07 17:56:45 luxman-volumio volumio[9581]: syscall: 'connect', Feb 07 17:56:45 luxman-volumio volumio[9581]: address: '199.232.174.53', Feb 07 17:56:45 luxman-volumio volumio[9581]: port: 443 Feb 07 17:56:45 luxman-volumio volumio[9581]: } Feb 07 17:56:45 luxman-volumio volumio[9581]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:56:45 luxman-volumio sudo[9929]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:45 luxman-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 07 17:56:45 luxman-volumio systemd[1]: shairport-sync.service: Succeeded. Feb 07 17:56:45 luxman-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:45 luxman-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:45 luxman-volumio sudo[9929]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:45 luxman-volumio sudo[9928]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 17:56:45 luxman-volumio sudo[9928]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:45 luxman-volumio sudo[9928]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:45 luxman-volumio sudo[9959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 17:55 Feb 07 17:56:45 luxman-volumio sudo[9959]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:45 luxman-volumio sudo[9959]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:45 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:45] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 17:56:45 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:45] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 17:56:45 luxman-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:45 luxman-volumio sudo[9901]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:45 luxman-volumio sudo[9784]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:45 luxman-volumio sudo[9805]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:45 luxman-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 17:56:45 luxman-volumio systemd[1]: Started dynamicswap service. Feb 07 17:56:45 luxman-volumio systemd[1]: dynamicswap.service: Succeeded. Feb 07 17:56:46 luxman-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 17:56:46 luxman-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Feb 07 17:56:46 luxman-volumio systemd[1]: Started dynamicswap service. Feb 07 17:56:46 luxman-volumio systemd[1]: Stopped Volumio Backend Module. Feb 07 17:56:46 luxman-volumio systemd[1]: Started Volumio Backend Module. Feb 07 17:56:46 luxman-volumio systemd[1]: dynamicswap.service: Succeeded. Feb 07 17:56:46 luxman-volumio mpd[9957]: Feb 07 17:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 17:56:46 luxman-volumio systemd[1]: Started Music Player Daemon. Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ------------------------------------------- Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ----- Volumio3 ---- Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ------------------------------------------- Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ----- System startup ---- Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ------------------------------------------- Feb 07 17:56:47 luxman-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Feb 07 17:56:47 luxman-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Feb 07 17:56:47 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:56:47 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:56:47 luxman-volumio go-librespot[10012]: go-librespot daemon starting... Feb 07 17:56:47 luxman-volumio go-librespot[10012]: time="2026-02-07T17:56:47+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:56:47 luxman-volumio go-librespot[10012]: time="2026-02-07T17:56:47+01:00" level=debug msg="app state loaded" Feb 07 17:56:47 luxman-volumio go-librespot[10012]: time="2026-02-07T17:56:47+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:56:47 luxman-volumio go-librespot[10012]: time="2026-02-07T17:56:47+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:56:47 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:47 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:56:47 luxman-volumio volumio[9989]: info: MYVOLUMIO Environment detected Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Plugin folders cleanup Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning into folder /volumio/app/plugins/ Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category audio_interface Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category miscellanea Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category music_service Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category plugins.json Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category system_controller Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category user_interface Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning into folder /data/plugins/ Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category audio_interface Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category music_service Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category system_controller Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Scanning category user_interface Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Plugin folders cleanup completed Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ------------------------------------------- Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ----- Core plugins startup ---- Feb 07 17:56:47 luxman-volumio volumio[9989]: info: ------------------------------------------- Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Adding plugin upnp to MyMusic Plugins Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Loading plugins from folder /data/plugins/ Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Loading plugin "system"... Feb 07 17:56:47 luxman-volumio volumio[9989]: info: Loading plugin "appearance"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "network"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Refreshing Cached IP Addresses Feb 07 17:56:48 luxman-volumio sudo[10025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 17:56:48 luxman-volumio sudo[10027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "services"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "alsa_controller"... Feb 07 17:56:48 luxman-volumio sudo[10025]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:48 luxman-volumio sudo[10027]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:48 luxman-volumio sudo[10025]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:48 luxman-volumio sudo[10027]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:48 luxman-volumio sudo[10039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 17:56:48 luxman-volumio sudo[10039]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:48 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "wizard"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "networkfs"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Starting Udev Watcher for removable devices Feb 07 17:56:48 luxman-volumio sudo[10076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.50.99/w-usb/%23 Musik /mnt/NAS/Musik_på_NAS Feb 07 17:56:48 luxman-volumio sudo[10076]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Ignoring mount for partition: BOOT Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Ignoring mount for partition: volumio Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Ignoring mount for partition: volumio_data Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Mounting Device Foto_SSD Feb 07 17:56:48 luxman-volumio volumio[9989]: /bin/mkdir: cannot create directory ‘/mnt/USB/Foto_SSD’: File exists Feb 07 17:56:48 luxman-volumio volumio[9989]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/Foto_SSD" Feb 07 17:56:48 luxman-volumio volumio[9989]: /bin/mkdir: cannot create directory ‘/mnt/USB/Foto_SSD’: File exists Feb 07 17:56:48 luxman-volumio sudo[10095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Foto_SSD -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:48 luxman-volumio sudo[10095]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:48 luxman-volumio sudo[10076]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:48 luxman-volumio kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE Feb 07 17:56:48 luxman-volumio kernel: CIFS VFS: Send error in SessSetup = -13 Feb 07 17:56:48 luxman-volumio kernel: CIFS VFS: cifs_mount failed w/return code = -13 Feb 07 17:56:48 luxman-volumio sudo[10095]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:48 luxman-volumio volumio[9989]: Mount is denied because the NTFS volume is already exclusively opened. Feb 07 17:56:48 luxman-volumio volumio[9989]: The volume may be already mounted, or another software may use it which Feb 07 17:56:48 luxman-volumio volumio[9989]: could be identified for example by the help of the 'fuser' command. Feb 07 17:56:48 luxman-volumio volumio[9989]: error: Failed to mount Foto_SSD: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/Foto_SSD" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:48 luxman-volumio volumio[9989]: Mount is denied because the NTFS volume is already exclusively opened. Feb 07 17:56:48 luxman-volumio volumio[9989]: The volume may be already mounted, or another software may use it which Feb 07 17:56:48 luxman-volumio volumio[9989]: could be identified for example by the help of the 'fuser' command. Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Mounting Device 1F17-3DEC Feb 07 17:56:48 luxman-volumio sudo[10039]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:48 luxman-volumio sudo[10112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/1F17-3DEC -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:48 luxman-volumio sudo[10112]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:48 luxman-volumio sudo[10112]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:48 luxman-volumio volumio[9989]: mount: /media/1F17-3DEC: /dev/sda2 already mounted on /media/1F17-3DEC. Feb 07 17:56:48 luxman-volumio volumio[9989]: error: Failed to mount 1F17-3DEC: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/1F17-3DEC" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:48 luxman-volumio volumio[9989]: mount: /media/1F17-3DEC: /dev/sda2 already mounted on /media/1F17-3DEC. Feb 07 17:56:48 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "volumio_command_line_client"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "upnp"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: [1770483408647] Starting Upmpd Daemon Feb 07 17:56:48 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "my_music"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "mpd"... Feb 07 17:56:48 luxman-volumio volumio[9989]: info: Loading plugin "upnp_browser"... Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Starting UPNP Browser Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "alarm-clock"... Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "airplay_emulation"... Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Starting Shairport Sync Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "last_100"... Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "webradio"... Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "i2s_dacs"... Feb 07 17:56:49 luxman-volumio volumio[9989]: info: I2S DAC not set, start Auto-detection Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "volumiodiscovery"... Feb 07 17:56:49 luxman-volumio volumio[9989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:49 luxman-volumio node[9989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:49 luxman-volumio volumio[9989]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:49 luxman-volumio node[9989]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:49 luxman-volumio volumio[9989]: *** WARNING *** For more information see Feb 07 17:56:49 luxman-volumio node[9989]: *** WARNING *** For more information see Feb 07 17:56:49 luxman-volumio volumio[9989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:49 luxman-volumio node[9989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:49 luxman-volumio volumio[9989]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:49 luxman-volumio node[9989]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:49 luxman-volumio volumio[9989]: *** WARNING *** For more information see Feb 07 17:56:49 luxman-volumio node[9989]: *** WARNING *** For more information see Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Discovery: Started advertising with name: LUXMAN Volumio Feb 07 17:56:49 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "spop"... Feb 07 17:56:49 luxman-volumio volumio[9989]: info: Loading plugin "now_playing"... Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Loading plugin "outputs"... Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Loading plugin "albumart"... Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Plugin example_plugin is not enabled Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Loading plugin "inputs"... Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Loading plugin "updater_comm"... Feb 07 17:56:50 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:50] [connect] Successful connection Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Plugin mpdemulation is not enabled Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Loading plugin "rest_api"... Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Loading plugin "websocket"... Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Starting Socket.io Server version 2.3.0 Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Loading plugin "fusiondsp"... Feb 07 17:56:50 luxman-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Feb 07 17:56:50 luxman-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Feb 07 17:56:50 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:56:50 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:56:50 luxman-volumio go-librespot[10133]: go-librespot daemon starting... Feb 07 17:56:50 luxman-volumio go-librespot[10133]: time="2026-02-07T17:56:50+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:56:50 luxman-volumio go-librespot[10133]: time="2026-02-07T17:56:50+01:00" level=debug msg="app state loaded" Feb 07 17:56:50 luxman-volumio go-librespot[10133]: time="2026-02-07T17:56:50+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:56:50 luxman-volumio go-librespot[10133]: time="2026-02-07T17:56:50+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:56:50 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:50 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:56:50 luxman-volumio volumio[9989]: Forking 3 albumart workers Feb 07 17:56:50 luxman-volumio volumio[9989]: info: Applying required configuration parameters for plugin fusiondsp Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Loading plugin "backup_restore"... Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Applying required configuration parameters for plugin backup_restore Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Loading i18n strings for locale sv Feb 07 17:56:51 luxman-volumio volumio[9989]: Updating browse sources language Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::initPlayerControls Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: Express server listening on port 3000 Feb 07 17:56:51 luxman-volumio volumio[9989]: [Metrics] WebUI: 4s 545.70ms Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreStateMachine::resetVolumioState Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreStateMachine::getcurrentVolume Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:51 luxman-volumio volumio[9989]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Completed loading Core Plugins Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Preparing to generate the ALSA configuration file Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Volumio Network Manager: Network status updated: 2 Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Cannot mount NAS Musik_på_NAS at system boot, trial number 1 ,retrying in 5 seconds Feb 07 17:56:51 luxman-volumio volumio[9989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Reading ALSA contributions from plugins. Feb 07 17:56:51 luxman-volumio volumio[9989]: Starting albumart workers Feb 07 17:56:51 luxman-volumio volumio[9989]: Starting albumart workers Feb 07 17:56:51 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 1 Feb 07 17:56:51 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 192.168.50.79 from 192.168.50.239 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Feb 07 17:56:51 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 192.168.50.79:3000 from 192.168.50.239 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Feb 07 17:56:51 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 4 Feb 07 17:56:51 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:51] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770483410 101 Feb 07 17:56:51 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 5 Feb 07 17:56:51 luxman-volumio volumio[9989]: Starting albumart workers Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:56:51 luxman-volumio volumio[9989]: info: Discovery: Getting this device information Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:51 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Reloading queue from file Feb 07 17:56:52 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 192.168.50.79:3000 from 192.168.50.239 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: VolumeController:: Volume=89 Mute =false Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreStateMachine::pushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreStateMachine::updateTrackBlock Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrackBlock Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreStateMachine::setRepeat null single undefined Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreStateMachine::pushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreStateMachine::setRandom false Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreStateMachine::pushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Setting Device type: Tinkerboard Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Discovery: Getting this device information Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 17:56:52 luxman-volumio volumio[9989]: info: VolumeController:: Volume=89 Mute =false Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreStateMachine::pushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioPushState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Asound.conf file unchanged, so no further update is needed Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Output device has changed, restarting MPD Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Output device has changed, restarting Shairport Sync Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:52 luxman-volumio sudo[10198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:56:52 luxman-volumio sudo[10200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:56:52 luxman-volumio sudo[10198]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:52 luxman-volumio volumio[9989]: info: ___________ START PLUGINS ___________ Feb 07 17:56:52 luxman-volumio sudo[10200]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:52 luxman-volumio volumio[9989]: info: ControllerMpd::onStart: Initializing MPD Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Creating MPD Configuration file Feb 07 17:56:52 luxman-volumio sudo[10198]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:52 luxman-volumio systemd[1]: Stopping Music Player Daemon... Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:56:52 luxman-volumio volumio[9989]: info: [1770483412418] CoreMusicLibrary::Adding element Mediaservrar Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:52 luxman-volumio sudo[10218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:56:52 luxman-volumio volumio[9989]: info: UPNP Browser: Client initialized successfully Feb 07 17:56:52 luxman-volumio sudo[10222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:52 luxman-volumio sudo[10218]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:52 luxman-volumio systemd[1]: mpd.service: Succeeded. Feb 07 17:56:52 luxman-volumio systemd[1]: Stopped Music Player Daemon. Feb 07 17:56:52 luxman-volumio sudo[10222]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:52 luxman-volumio systemd[1]: Starting Music Player Daemon... Feb 07 17:56:52 luxman-volumio sudo[10218]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:52 luxman-volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 17:56:52 luxman-volumio systemd[1]: mpd.service: Succeeded. Feb 07 17:56:52 luxman-volumio systemd[1]: Stopped Music Player Daemon. Feb 07 17:56:52 luxman-volumio systemd[1]: Starting Music Player Daemon... Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:56:52 luxman-volumio volumio[9989]: info: [1770483412518] CoreMusicLibrary::Adding element Last_100 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:56:52 luxman-volumio volumio[9989]: info: [1770483412520] CoreMusicLibrary::Adding element Webradio Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Initializing BBC Radios Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Creating Spotify config file Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio sudo[10242]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 17:56:52 luxman-volumio sudo[10242]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:52 luxman-volumio sudo[10242]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:52 luxman-volumio volumio[9989]: info: [now-playing] ConfigUpdater: config is up to date. Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Loading i18n strings for locale sv Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: FusionDsp - mixtype--------------------- Hardware Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Volumio Calling Home Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Preparing to generate the ALSA configuration file Feb 07 17:56:52 luxman-volumio volumio[9989]: info: [now-playing] App is listening on port 4004. Feb 07 17:56:52 luxman-volumio volumio[9989]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Discovery: adding 10a99ae7-142c-4cfb-b085-cd51c47c9dd8 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Discovery: Found device LUXMAN Volumio Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:52 luxman-volumio volumio[9989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Reading ALSA contributions from plugins. Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Volumio called home Feb 07 17:56:52 luxman-volumio volumio[9989]: info: MPD Permissions set Feb 07 17:56:52 luxman-volumio volumio[9989]: info: MPD Permissions set Feb 07 17:56:52 luxman-volumio volumio[9989]: info: Spotify config file written Feb 07 17:56:52 luxman-volumio sudo[10267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 07 17:56:52 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 07 17:56:52 luxman-volumio sudo[10267]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:56:52 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:56:52 luxman-volumio sudo[10267]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:52 luxman-volumio go-librespot[10277]: go-librespot daemon starting... Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:52+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:56:52 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:52+01:00" level=debug msg="app state loaded" Feb 07 17:56:52 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:52+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:56:52 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:52 luxman-volumio volumio[9989]: info: No need to fix Spotify hosts Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Starting Shairport Sync Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Starting Shairport Sync Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Starting Shairport Sync Feb 07 17:56:53 luxman-volumio sudo[10297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:53 luxman-volumio sudo[10300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:53 luxman-volumio sudo[10297]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:53 luxman-volumio sudo[10302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:53 luxman-volumio sudo[10300]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:53 luxman-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 07 17:56:53 luxman-volumio systemd[1]: shairport-sync.service: Succeeded. Feb 07 17:56:53 luxman-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:53 luxman-volumio sudo[10302]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Asound.conf file unchanged, so no further update is needed Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Output device has changed, restarting MPD Feb 07 17:56:53 luxman-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:53 luxman-volumio sudo[10297]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Output device has changed, restarting Shairport Sync Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:53 luxman-volumio sudo[10320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:56:53 luxman-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 07 17:56:53 luxman-volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 07 17:56:53 luxman-volumio systemd[1]: shairport-sync.service: Succeeded. Feb 07 17:56:53 luxman-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:53 luxman-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:53 luxman-volumio sudo[10300]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:53 luxman-volumio sudo[10302]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:53 luxman-volumio sudo[10326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:56:53 luxman-volumio sudo[10320]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:53 luxman-volumio sudo[10320]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:53 luxman-volumio sudo[10326]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:53 luxman-volumio volumio[9989]: info: New Spotify access tokenBQBno_BBfD... Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Spotify credentials grant success - running version from March 24, 2019 Feb 07 17:56:53 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 192.168.50.79 from 192.168.50.239 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Shairport-Sync Started Feb 07 17:56:53 luxman-volumio volumio[9989]: Error adding Membership: Error: addMembership EINVAL Feb 07 17:56:53 luxman-volumio volumio[9989]: info: MPD Permissions set Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Shairport-Sync Started Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Shairport-Sync Started Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:56:53 luxman-volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 07 17:56:53 luxman-volumio systemd[1]: mpd.service: Succeeded. Feb 07 17:56:53 luxman-volumio systemd[1]: Stopped Music Player Daemon. Feb 07 17:56:53 luxman-volumio systemd[1]: Starting Music Player Daemon... Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:56:53 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:53+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 07 17:56:53 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:53+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 07 17:56:53 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:53+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 07 17:56:53 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:53+01:00" level=info msg="zeroconf server listening on port 43251" Feb 07 17:56:53 luxman-volumio volumio[9989]: error: Failed to retrieve user informations: Error: connect EHOSTUNREACH 35.186.224.24:443 Feb 07 17:56:53 luxman-volumio volumio[9989]: error: Spotify credentials failed to read user data: Feb 07 17:56:53 luxman-volumio volumio[9989]: info: An error occurred while initializing Spotify Browsing facility: Feb 07 17:56:53 luxman-volumio sudo[10356]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 17:56:53 luxman-volumio go-librespot[10277]: time="2026-02-07T17:56:53+01:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:56:53 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:53 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Starting Shairport Sync Feb 07 17:56:53 luxman-volumio sudo[10356]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:53 luxman-volumio sudo[10356]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:53 luxman-volumio sudo[10365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:56:53 luxman-volumio sudo[10365]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 17:56:53 luxman-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 07 17:56:53 luxman-volumio systemd[1]: shairport-sync.service: Succeeded. Feb 07 17:56:53 luxman-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:53 luxman-volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Feb 07 17:56:53 luxman-volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Feb 07 17:56:53 luxman-volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Feb 07 17:56:53 luxman-volumio sudo[10365]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetVisibleSources Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Received Get System Info Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Discovery: Getting this device information Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Listing playlists Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetQueue Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreStateMachine::getQueue Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CorePlayQueue::getQueue Feb 07 17:56:53 luxman-volumio volumio[9989]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Feb 07 17:56:53 luxman-volumio volumio[9989]: Job for shairport-sync.service failed. Feb 07 17:56:53 luxman-volumio volumio[9989]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 17:56:53 luxman-volumio volumio[9989]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 07 17:56:53 luxman-volumio volumio[9989]: info: FusionDsp - Bass-FusionDsp Feb 07 17:56:53 luxman-volumio volumio[9989]: info: FusionDsp - Bass-FusionDsp Feb 07 17:56:54 luxman-volumio volumio[9989]: info: FusionDsp - Bass-FusionDsp Feb 07 17:56:54 luxman-volumio volumio[9989]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Feb 07 17:56:54 luxman-volumio volumio[9989]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Feb 07 17:56:54 luxman-volumio volumio[9989]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Feb 07 17:56:54 luxman-volumio volumio[9989]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 8 Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetVisibleSources Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 17:56:54 luxman-volumio volumio[9989]: info: Received Get System Info Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:56:54 luxman-volumio volumio[9989]: info: Discovery: Getting this device information Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CoreCommandRouter::volumioGetState Feb 07 17:56:54 luxman-volumio volumio[9989]: info: CorePlayQueue::getTrack 0 Feb 07 17:56:54 luxman-volumio volumio[9989]: info: Listing playlists Feb 07 17:56:54 luxman-volumio mpd[10373]: Feb 07 17:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 17:56:54 luxman-volumio systemd[1]: Started Music Player Daemon. Feb 07 17:56:54 luxman-volumio sudo[10326]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:54 luxman-volumio sudo[10200]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:54 luxman-volumio sudo[10222]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:54 luxman-volumio volumio[9989]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:56:54 luxman-volumio volumio[9989]: Error: connect EHOSTUNREACH 199.232.174.53:443 Feb 07 17:56:54 luxman-volumio volumio[9989]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 07 17:56:54 luxman-volumio volumio[9989]: errno: -113, Feb 07 17:56:54 luxman-volumio volumio[9989]: code: 'EHOSTUNREACH', Feb 07 17:56:54 luxman-volumio volumio[9989]: syscall: 'connect', Feb 07 17:56:54 luxman-volumio volumio[9989]: address: '199.232.174.53', Feb 07 17:56:54 luxman-volumio volumio[9989]: port: 443 Feb 07 17:56:54 luxman-volumio volumio[9989]: } Feb 07 17:56:54 luxman-volumio volumio[9989]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:56:55 luxman-volumio sudo[10397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 17:55 Feb 07 17:56:55 luxman-volumio sudo[10397]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:55 luxman-volumio sudo[10397]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:55 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:55] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 17:56:55 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:56:55] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 17:56:55 luxman-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:55 luxman-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 17:56:55 luxman-volumio systemd[1]: Started dynamicswap service. Feb 07 17:56:55 luxman-volumio systemd[1]: dynamicswap.service: Succeeded. Feb 07 17:56:55 luxman-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 17:56:55 luxman-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Feb 07 17:56:55 luxman-volumio systemd[1]: Started dynamicswap service. Feb 07 17:56:55 luxman-volumio systemd[1]: Stopped Volumio Backend Module. Feb 07 17:56:55 luxman-volumio systemd[1]: Started Volumio Backend Module. Feb 07 17:56:55 luxman-volumio systemd[1]: dynamicswap.service: Succeeded. Feb 07 17:56:56 luxman-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Feb 07 17:56:56 luxman-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Feb 07 17:56:56 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:56:56 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:56:56 luxman-volumio go-librespot[10431]: go-librespot daemon starting... Feb 07 17:56:56 luxman-volumio go-librespot[10431]: time="2026-02-07T17:56:56+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:56:56 luxman-volumio go-librespot[10431]: time="2026-02-07T17:56:56+01:00" level=debug msg="app state loaded" Feb 07 17:56:56 luxman-volumio go-librespot[10431]: time="2026-02-07T17:56:56+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:56:56 luxman-volumio go-librespot[10431]: time="2026-02-07T17:56:56+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:56:56 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:56 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:56:56 luxman-volumio volumio[10419]: info: ------------------------------------------- Feb 07 17:56:56 luxman-volumio volumio[10419]: info: ----- Volumio3 ---- Feb 07 17:56:56 luxman-volumio volumio[10419]: info: ------------------------------------------- Feb 07 17:56:56 luxman-volumio volumio[10419]: info: ----- System startup ---- Feb 07 17:56:56 luxman-volumio volumio[10419]: info: ------------------------------------------- Feb 07 17:56:57 luxman-volumio volumio[10419]: info: MYVOLUMIO Environment detected Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Plugin folders cleanup Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning into folder /volumio/app/plugins/ Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category audio_interface Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category miscellanea Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category music_service Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category plugins.json Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category system_controller Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category user_interface Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning into folder /data/plugins/ Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category audio_interface Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category music_service Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category system_controller Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Scanning category user_interface Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Plugin folders cleanup completed Feb 07 17:56:57 luxman-volumio volumio[10419]: info: ------------------------------------------- Feb 07 17:56:57 luxman-volumio volumio[10419]: info: ----- Core plugins startup ---- Feb 07 17:56:57 luxman-volumio volumio[10419]: info: ------------------------------------------- Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Adding plugin upnp to MyMusic Plugins Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Loading plugins from folder /data/plugins/ Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Loading plugin "system"... Feb 07 17:56:57 luxman-volumio volumio[10419]: info: Loading plugin "appearance"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "network"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Refreshing Cached IP Addresses Feb 07 17:56:58 luxman-volumio sudo[10453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 17:56:58 luxman-volumio sudo[10455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "services"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "alsa_controller"... Feb 07 17:56:58 luxman-volumio sudo[10453]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:58 luxman-volumio sudo[10455]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:58 luxman-volumio sudo[10453]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:58 luxman-volumio sudo[10467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 17:56:58 luxman-volumio sudo[10455]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:58 luxman-volumio sudo[10467]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:58 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "wizard"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "networkfs"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Starting Udev Watcher for removable devices Feb 07 17:56:58 luxman-volumio sudo[10506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.50.99/w-usb/%23 Musik /mnt/NAS/Musik_på_NAS Feb 07 17:56:58 luxman-volumio sudo[10506]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Ignoring mount for partition: BOOT Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Ignoring mount for partition: volumio Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Ignoring mount for partition: volumio_data Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Mounting Device Foto_SSD Feb 07 17:56:58 luxman-volumio volumio[10419]: /bin/mkdir: cannot create directory ‘/mnt/USB/Foto_SSD’: File exists Feb 07 17:56:58 luxman-volumio volumio[10419]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/Foto_SSD" Feb 07 17:56:58 luxman-volumio volumio[10419]: /bin/mkdir: cannot create directory ‘/mnt/USB/Foto_SSD’: File exists Feb 07 17:56:58 luxman-volumio kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE Feb 07 17:56:58 luxman-volumio kernel: CIFS VFS: Send error in SessSetup = -13 Feb 07 17:56:58 luxman-volumio kernel: CIFS VFS: cifs_mount failed w/return code = -13 Feb 07 17:56:58 luxman-volumio sudo[10506]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:58 luxman-volumio sudo[10525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Foto_SSD -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:58 luxman-volumio sudo[10525]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:58 luxman-volumio sudo[10525]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:58 luxman-volumio volumio[10419]: Mount is denied because the NTFS volume is already exclusively opened. Feb 07 17:56:58 luxman-volumio volumio[10419]: The volume may be already mounted, or another software may use it which Feb 07 17:56:58 luxman-volumio volumio[10419]: could be identified for example by the help of the 'fuser' command. Feb 07 17:56:58 luxman-volumio volumio[10419]: error: Failed to mount Foto_SSD: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/Foto_SSD" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:58 luxman-volumio volumio[10419]: Mount is denied because the NTFS volume is already exclusively opened. Feb 07 17:56:58 luxman-volumio volumio[10419]: The volume may be already mounted, or another software may use it which Feb 07 17:56:58 luxman-volumio volumio[10419]: could be identified for example by the help of the 'fuser' command. Feb 07 17:56:58 luxman-volumio sudo[10467]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Mounting Device 1F17-3DEC Feb 07 17:56:58 luxman-volumio sudo[10545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/1F17-3DEC -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:58 luxman-volumio sudo[10545]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:56:58 luxman-volumio sudo[10545]: pam_unix(sudo:session): session closed for user root Feb 07 17:56:58 luxman-volumio volumio[10419]: mount: /media/1F17-3DEC: /dev/sda2 already mounted on /media/1F17-3DEC. Feb 07 17:56:58 luxman-volumio volumio[10419]: error: Failed to mount 1F17-3DEC: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/1F17-3DEC" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 07 17:56:58 luxman-volumio volumio[10419]: mount: /media/1F17-3DEC: /dev/sda2 already mounted on /media/1F17-3DEC. Feb 07 17:56:58 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "volumio_command_line_client"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "upnp"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: [1770483418554] Starting Upmpd Daemon Feb 07 17:56:58 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "my_music"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "mpd"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "upnp_browser"... Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Starting UPNP Browser Feb 07 17:56:58 luxman-volumio volumio[10419]: info: Loading plugin "alarm-clock"... Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Loading plugin "airplay_emulation"... Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Starting Shairport Sync Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Loading plugin "last_100"... Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Loading plugin "webradio"... Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Loading plugin "i2s_dacs"... Feb 07 17:56:59 luxman-volumio volumio[10419]: info: I2S DAC not set, start Auto-detection Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Loading plugin "volumiodiscovery"... Feb 07 17:56:59 luxman-volumio volumio[10419]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:59 luxman-volumio volumio[10419]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:59 luxman-volumio volumio[10419]: *** WARNING *** For more information see Feb 07 17:56:59 luxman-volumio volumio[10419]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:59 luxman-volumio volumio[10419]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:59 luxman-volumio node[10419]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:59 luxman-volumio volumio[10419]: *** WARNING *** For more information see Feb 07 17:56:59 luxman-volumio node[10419]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:59 luxman-volumio node[10419]: *** WARNING *** For more information see Feb 07 17:56:59 luxman-volumio node[10419]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 17:56:59 luxman-volumio node[10419]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 17:56:59 luxman-volumio node[10419]: *** WARNING *** For more information see Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Discovery: Started advertising with name: LUXMAN Volumio Feb 07 17:56:59 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 17:56:59 luxman-volumio volumio[10419]: info: Loading plugin "spop"... Feb 07 17:56:59 luxman-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Feb 07 17:56:59 luxman-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Feb 07 17:56:59 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:56:59 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:56:59 luxman-volumio go-librespot[10556]: go-librespot daemon starting... Feb 07 17:56:59 luxman-volumio go-librespot[10556]: time="2026-02-07T17:56:59+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:56:59 luxman-volumio go-librespot[10556]: time="2026-02-07T17:56:59+01:00" level=debug msg="app state loaded" Feb 07 17:56:59 luxman-volumio go-librespot[10556]: time="2026-02-07T17:56:59+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:56:59 luxman-volumio go-librespot[10556]: time="2026-02-07T17:56:59+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:56:59 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:56:59 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:57:00 luxman-volumio volumio[10419]: info: Loading plugin "now_playing"... Feb 07 17:57:00 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:57:00] [connect] Successful connection Feb 07 17:57:00 luxman-volumio volumio[10419]: info: Loading plugin "outputs"... Feb 07 17:57:00 luxman-volumio volumio[10419]: info: Loading plugin "albumart"... Feb 07 17:57:00 luxman-volumio volumio[10419]: info: Plugin example_plugin is not enabled Feb 07 17:57:00 luxman-volumio volumio[10419]: info: Loading plugin "inputs"... Feb 07 17:57:00 luxman-volumio volumio[10419]: info: Loading plugin "updater_comm"... Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Plugin mpdemulation is not enabled Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Loading plugin "rest_api"... Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Loading plugin "websocket"... Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Starting Socket.io Server version 2.3.0 Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Loading plugin "fusiondsp"... Feb 07 17:57:01 luxman-volumio volumio[10419]: Forking 3 albumart workers Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Applying required configuration parameters for plugin fusiondsp Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Loading plugin "backup_restore"... Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Applying required configuration parameters for plugin backup_restore Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Loading i18n strings for locale sv Feb 07 17:57:01 luxman-volumio volumio[10419]: Updating browse sources language Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::initPlayerControls Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: Express server listening on port 3000 Feb 07 17:57:01 luxman-volumio volumio[10419]: [Metrics] WebUI: 5s 429.46ms Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreStateMachine::resetVolumioState Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreStateMachine::getcurrentVolume Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 17:57:01 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:01 luxman-volumio volumio[10419]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Completed loading Core Plugins Feb 07 17:57:01 luxman-volumio volumio[10419]: info: Preparing to generate the ALSA configuration file Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Volumio Network Manager: Network status updated: 2 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Cannot mount NAS Musik_på_NAS at system boot, trial number 1 ,retrying in 5 seconds Feb 07 17:57:02 luxman-volumio volumio[10419]: Starting albumart workers Feb 07 17:57:02 luxman-volumio volumio[10419]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Reading ALSA contributions from plugins. Feb 07 17:57:02 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 1 Feb 07 17:57:02 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 192.168.50.79:3000 from 192.168.50.239 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Feb 07 17:57:02 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 3 Feb 07 17:57:02 luxman-volumio volumio-remote-updater[594]: [2026-02-07 17:57:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770483420 101 Feb 07 17:57:02 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Feb 07 17:57:02 luxman-volumio volumio[10419]: Starting albumart workers Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Discovery: Getting this device information Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioGetState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:57:02 luxman-volumio volumio[10419]: Starting albumart workers Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Reloading queue from file Feb 07 17:57:02 luxman-volumio volumio[10419]: info: VolumeController:: Volume=89 Mute =false Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreStateMachine::pushState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioPushState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreStateMachine::updateTrackBlock Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrackBlock Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreStateMachine::setRepeat null single undefined Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreStateMachine::pushState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioPushState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreStateMachine::setRandom false Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreStateMachine::pushState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioPushState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Setting Device type: Tinkerboard Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Discovery: Getting this device information Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioGetState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 17:57:02 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 192.168.50.79:3000 from 192.168.50.239 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 17:57:02 luxman-volumio volumio[10419]: info: VolumeController:: Volume=89 Mute =false Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreStateMachine::pushState Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioPushState Feb 07 17:57:02 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 192.168.50.79 from 192.168.50.239 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Asound.conf file unchanged, so no further update is needed Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Output device has changed, restarting MPD Feb 07 17:57:02 luxman-volumio volumio[10419]: info: Output device has changed, restarting Shairport Sync Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:02 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:03 luxman-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Feb 07 17:57:03 luxman-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Feb 07 17:57:03 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:57:03 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:57:03 luxman-volumio go-librespot[10622]: go-librespot daemon starting... Feb 07 17:57:03 luxman-volumio sudo[10614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:57:03 luxman-volumio sudo[10612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:57:03 luxman-volumio go-librespot[10622]: time="2026-02-07T17:57:03+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:57:03 luxman-volumio go-librespot[10622]: time="2026-02-07T17:57:03+01:00" level=debug msg="app state loaded" Feb 07 17:57:03 luxman-volumio sudo[10614]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:03 luxman-volumio go-librespot[10622]: time="2026-02-07T17:57:03+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:57:03 luxman-volumio volumio[10419]: info: ___________ START PLUGINS ___________ Feb 07 17:57:03 luxman-volumio volumio[10419]: info: ControllerMpd::onStart: Initializing MPD Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Creating MPD Configuration file Feb 07 17:57:03 luxman-volumio go-librespot[10622]: time="2026-02-07T17:57:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:57:03 luxman-volumio sudo[10612]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:03 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:57:03 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:57:03 luxman-volumio sudo[10612]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:03 luxman-volumio systemd[1]: Stopping Music Player Daemon... Feb 07 17:57:03 luxman-volumio sudo[10645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:57:03 luxman-volumio volumio[10419]: info: [1770483423180] CoreMusicLibrary::Adding element Mediaservrar Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:57:03 luxman-volumio systemd[1]: mpd.service: Succeeded. Feb 07 17:57:03 luxman-volumio systemd[1]: Stopped Music Player Daemon. Feb 07 17:57:03 luxman-volumio systemd[1]: Starting Music Player Daemon... Feb 07 17:57:03 luxman-volumio sudo[10645]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:03 luxman-volumio volumio[10419]: info: UPNP Browser: Client initialized successfully Feb 07 17:57:03 luxman-volumio sudo[10650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:57:03 luxman-volumio sudo[10645]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:03 luxman-volumio sudo[10650]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:03 luxman-volumio sudo[10653]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 17:57:03 luxman-volumio sudo[10653]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:03 luxman-volumio sudo[10653]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:57:03 luxman-volumio volumio[10419]: info: [1770483423363] CoreMusicLibrary::Adding element Last_100 Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 17:57:03 luxman-volumio volumio[10419]: info: [1770483423367] CoreMusicLibrary::Adding element Webradio Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Initializing BBC Radios Feb 07 17:57:03 luxman-volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 17:57:03 luxman-volumio systemd[1]: mpd.service: Succeeded. Feb 07 17:57:03 luxman-volumio systemd[1]: Stopped Music Player Daemon. Feb 07 17:57:03 luxman-volumio systemd[1]: Starting Music Player Daemon... Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Creating Spotify config file Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio sudo[10688]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 17:57:03 luxman-volumio volumio[10419]: info: [now-playing] ConfigUpdater: config is up to date. Feb 07 17:57:03 luxman-volumio sudo[10688]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Loading i18n strings for locale sv Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: FusionDsp - mixtype--------------------- Hardware Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Volumio Calling Home Feb 07 17:57:03 luxman-volumio sudo[10688]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Preparing to generate the ALSA configuration file Feb 07 17:57:03 luxman-volumio volumio[10419]: info: [now-playing] App is listening on port 4004. Feb 07 17:57:03 luxman-volumio volumio[10419]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Discovery: adding 10a99ae7-142c-4cfb-b085-cd51c47c9dd8 Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Discovery: Found device LUXMAN Volumio Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioGetState Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:03 luxman-volumio volumio[10419]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Reading ALSA contributions from plugins. Feb 07 17:57:03 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 6 Feb 07 17:57:03 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to 192.168.50.79 from 192.168.50.239 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 07 17:57:03 luxman-volumio volumio[10419]: info: MPD Permissions set Feb 07 17:57:03 luxman-volumio volumio[10419]: info: MPD Permissions set Feb 07 17:57:03 luxman-volumio volumio[10419]: info: An error occurred while refreshing Spotify Token Error: connect EHOSTUNREACH 66.241.124.64:443 Feb 07 17:57:03 luxman-volumio volumio[10419]: info: Spotify config file written Feb 07 17:57:03 luxman-volumio volumio[10419]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio sudo[10709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 07 17:57:03 luxman-volumio sudo[10709]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio systemd[1]: Stopped go-librespot Daemon. Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio systemd[1]: Started go-librespot Daemon. Feb 07 17:57:03 luxman-volumio sudo[10709]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:03 luxman-volumio go-librespot[10721]: go-librespot daemon starting... Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:57:03 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:03 luxman-volumio volumio[10419]: info: No need to fix Spotify hosts Feb 07 17:57:03 luxman-volumio go-librespot[10721]: time="2026-02-07T17:57:03+01:00" level=info msg="running go-librespot 0.6.2" Feb 07 17:57:03 luxman-volumio go-librespot[10721]: time="2026-02-07T17:57:03+01:00" level=debug msg="app state loaded" Feb 07 17:57:03 luxman-volumio go-librespot[10721]: time="2026-02-07T17:57:03+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 07 17:57:03 luxman-volumio go-librespot[10721]: time="2026-02-07T17:57:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: connect: no route to host" Feb 07 17:57:03 luxman-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 07 17:57:03 luxman-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Starting Shairport Sync Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Starting Shairport Sync Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Starting Shairport Sync Feb 07 17:57:04 luxman-volumio sudo[10739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:57:04 luxman-volumio sudo[10739]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:04 luxman-volumio sudo[10742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::volumioGetState Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CorePlayQueue::getTrack 0 Feb 07 17:57:04 luxman-volumio sudo[10745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 07 17:57:04 luxman-volumio sudo[10742]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:04 luxman-volumio sudo[10745]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:04 luxman-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Asound.conf file unchanged, so no further update is needed Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Output device has changed, restarting MPD Feb 07 17:57:04 luxman-volumio sudo[10739]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Output device has changed, restarting Shairport Sync Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:04 luxman-volumio sudo[10763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 17:57:04 luxman-volumio sudo[10763]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:04 luxman-volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 07 17:57:04 luxman-volumio systemd[1]: shairport-sync.service: Succeeded. Feb 07 17:57:04 luxman-volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 07 17:57:04 luxman-volumio sudo[10763]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:04 luxman-volumio sudo[10768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 17:57:04 luxman-volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 07 17:57:04 luxman-volumio sudo[10745]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:04 luxman-volumio sudo[10742]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:04 luxman-volumio sudo[10768]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:04 luxman-volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 07 17:57:04 luxman-volumio systemd[1]: mpd.service: Succeeded. Feb 07 17:57:04 luxman-volumio systemd[1]: Stopped Music Player Daemon. Feb 07 17:57:04 luxman-volumio systemd[1]: Starting Music Player Daemon... Feb 07 17:57:04 luxman-volumio volumio[10419]: info: MPD Permissions set Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Shairport-Sync Started Feb 07 17:57:04 luxman-volumio volumio[10419]: Error adding Membership: Error: addMembership EINVAL Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Shairport-Sync Started Feb 07 17:57:04 luxman-volumio volumio[10419]: info: Shairport-Sync Started Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 07 17:57:04 luxman-volumio sudo[10793]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 17:57:04 luxman-volumio volumio[10419]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 17:57:04 luxman-volumio sudo[10793]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 17:57:04 luxman-volumio volumio[10419]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:57:04 luxman-volumio sudo[10793]: pam_unix(sudo:session): session closed for user root Feb 07 17:57:04 luxman-volumio volumio[10419]: Error: connect EHOSTUNREACH 158.69.209.125:443 Feb 07 17:57:04 luxman-volumio volumio[10419]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 07 17:57:04 luxman-volumio volumio[10419]: errno: -113, Feb 07 17:57:04 luxman-volumio volumio[10419]: code: 'EHOSTUNREACH', Feb 07 17:57:04 luxman-volumio volumio[10419]: syscall: 'connect', Feb 07 17:57:04 luxman-volumio volumio[10419]: address: '158.69.209.125', Feb 07 17:57:04 luxman-volumio volumio[10419]: port: 443 Feb 07 17:57:04 luxman-volumio volumio[10419]: } Feb 07 17:57:04 luxman-volumio volumio[10419]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 17:57:05 luxman-volumio sudo[10818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 17:56 Feb 07 17:57:05 luxman-volumio sudo[10818]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:03:54 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="35e446ff98e90abcfcab1bb2733dfd3a"