-- Logs begin at Mon 2025-06-30 18:17:46 CEST, end at Mon 2025-06-30 19:11:14 CEST. -- Jun 30 19:10:05 volumio volumio[847]: info: Jun 30 19:10:05 volumio volumio[847]: ---------------------------- MPD announces state update: player Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::getState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Jun 30 19:10:05 volumio volumio[847]: info: Jun 30 19:10:05 volumio volumio[847]: ---------------------------- MPD announces state update: player Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::getState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Jun 30 19:10:05 volumio volumio[847]: info: Jun 30 19:10:05 volumio volumio[847]: ---------------------------- MPD announces state update: player Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::getState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Jun 30 19:10:05 volumio volumio[847]: info: Jun 30 19:10:05 volumio volumio[847]: ---------------------------- MPD announces state update: player Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::getState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand status took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand status took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand status took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand status took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseState Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseTrackInfo Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseTrackInfo Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseTrackInfo Jun 30 19:10:05 volumio volumio[847]: verbose: ControllerMpd::parseTrackInfo Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::servicePushState Jun 30 19:10:05 volumio volumio[847]: verbose: In UPNP mode Jun 30 19:10:05 volumio volumio[847]: verbose: STATE SERVICE {"status":"pause","position":5,"seek":219980,"duration":237,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1227 Kbps","isStreaming":false,"title":"Det kunne skjedd","artist":"Kari Bremnes","album":"Det vi har","uri":"https://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidiYTFlYWFiMzQwNGY5ZGYwYTNlNDQ2YzI4MDAwMjM5Y182Mi5tcDQ/0.flac?token=1751306704~NDA2Yjc3ZWYzY2ExYjY4N2UzYWE3MTg1OTBhMzJiYzU4MDk2YzYxZA==","trackType":"tidal"} Jun 30 19:10:05 volumio volumio[847]: verbose: CURRENT POSITION 0 Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState stateService pause Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus play Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::stPlaybackTimer Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::servicePushState Jun 30 19:10:05 volumio volumio[847]: verbose: In UPNP mode Jun 30 19:10:05 volumio volumio[847]: verbose: STATE SERVICE {"status":"pause","position":5,"seek":219980,"duration":237,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1227 Kbps","isStreaming":false,"title":"Det kunne skjedd","artist":"Kari Bremnes","album":"Det vi har","uri":"https://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidiYTFlYWFiMzQwNGY5ZGYwYTNlNDQ2YzI4MDAwMjM5Y182Mi5tcDQ/0.flac?token=1751306704~NDA2Yjc3ZWYzY2ExYjY4N2UzYWE3MTg1OTBhMzJiYzU4MDk2YzYxZA==","trackType":"tidal"} Jun 30 19:10:05 volumio volumio[847]: verbose: CURRENT POSITION 0 Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState stateService pause Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus play Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::stPlaybackTimer Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::servicePushState Jun 30 19:10:05 volumio volumio[847]: verbose: In UPNP mode Jun 30 19:10:05 volumio volumio[847]: verbose: STATE SERVICE {"status":"pause","position":5,"seek":219980,"duration":237,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1227 Kbps","isStreaming":false,"title":"Det kunne skjedd","artist":"Kari Bremnes","album":"Det vi har","uri":"https://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidiYTFlYWFiMzQwNGY5ZGYwYTNlNDQ2YzI4MDAwMjM5Y182Mi5tcDQ/0.flac?token=1751306704~NDA2Yjc3ZWYzY2ExYjY4N2UzYWE3MTg1OTBhMzJiYzU4MDk2YzYxZA==","trackType":"tidal"} Jun 30 19:10:05 volumio volumio[847]: verbose: CURRENT POSITION 0 Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState stateService pause Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus play Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::stPlaybackTimer Jun 30 19:10:05 volumio volumio[847]: info: ControllerMpd::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::servicePushState Jun 30 19:10:05 volumio volumio[847]: verbose: In UPNP mode Jun 30 19:10:05 volumio volumio[847]: verbose: STATE SERVICE {"status":"pause","position":5,"seek":219980,"duration":237,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1227 Kbps","isStreaming":false,"title":"Det kunne skjedd","artist":"Kari Bremnes","album":"Det vi har","uri":"https://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidiYTFlYWFiMzQwNGY5ZGYwYTNlNDQ2YzI4MDAwMjM5Y182Mi5tcDQ/0.flac?token=1751306704~NDA2Yjc3ZWYzY2ExYjY4N2UzYWE3MTg1OTBhMzJiYzU4MDk2YzYxZA==","trackType":"tidal"} Jun 30 19:10:05 volumio volumio[847]: verbose: CURRENT POSITION 0 Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState stateService pause Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus play Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::pushState Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::stPlaybackTimer Jun 30 19:10:05 volumio volumio[847]: info: ------------------------------ 4ms Jun 30 19:10:05 volumio volumio[847]: info: ------------------------------ 3ms Jun 30 19:10:05 volumio volumio[847]: info: ------------------------------ 4ms Jun 30 19:10:05 volumio volumio[847]: info: ------------------------------ 4ms Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetQueue Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::getQueue Jun 30 19:10:05 volumio volumio[847]: info: CorePlayQueue::getQueue Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetQueue Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::getQueue Jun 30 19:10:05 volumio volumio[847]: info: CorePlayQueue::getQueue Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetQueue Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::getQueue Jun 30 19:10:05 volumio volumio[847]: info: CorePlayQueue::getQueue Jun 30 19:10:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetQueue Jun 30 19:10:05 volumio volumio[847]: info: CoreStateMachine::getQueue Jun 30 19:10:05 volumio volumio[847]: info: CorePlayQueue::getQueue Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: SPOTIFY VOLUME 89 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: DELTA VOLUME ENOUGH: false Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: SPOTIFY VOLUME 89 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: DELTA VOLUME ENOUGH: false Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: SPOTIFY VOLUME 89 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: DELTA VOLUME ENOUGH: false Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: SPOTIFY VOLUME 89 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: VOLUMIO VOLUME 90 Jun 30 19:10:05 volumio volumio[847]: SPOTIFY: DELTA VOLUME ENOUGH: false Jun 30 19:10:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:10:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:10:12 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:10:12 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:10:12 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.1.16:3000 from 192.168.1.22 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jun 30 19:10:12 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 19:10:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 19:10:13 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:10:13 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:10:13 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:10:13 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:13 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:10:17 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:17 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.1.16:3000 from 192.168.1.22 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jun 30 19:10:17 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 19:10:17 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 19:10:17 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:18 volumio sudo[15704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 19:10:18 volumio sudo[15704]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:10:18 volumio sudo[15704]: pam_unix(sudo:session): session closed for user root Jun 30 19:10:18 volumio sudo[15707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 19:10:18 volumio sudo[15707]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:10:18 volumio sudo[15707]: pam_unix(sudo:session): session closed for user root Jun 30 19:10:19 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 30 19:10:19 volumio sudo[15712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 19:10:19 volumio sudo[15712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:10:19 volumio sudo[15712]: pam_unix(sudo:session): session closed for user root Jun 30 19:10:19 volumio sudo[15715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 19:10:19 volumio sudo[15715]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:10:19 volumio sudo[15715]: pam_unix(sudo:session): session closed for user root Jun 30 19:10:19 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 30 19:10:19 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 19:10:20 volumio volumio[847]: info: Received Get System Info Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:10:20 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:20 volumio volumio[847]: info: Listing playlists Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 30 19:10:20 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 30 19:10:21 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 30 19:10:21 volumio volumio[847]: info: Received Get System Info Jun 30 19:10:21 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:10:21 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:10:21 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:10:21 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:21 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:10:22 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 30 19:10:23 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 30 19:10:23 volumio volumio[847]: info: Received Get System Info Jun 30 19:10:23 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:10:23 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:10:23 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:10:23 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:23 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:10:23 volumio go-librespot[1824]: time="2025-06-30T19:10:23+02:00" level=trace msg="sent dealer ping" Jun 30 19:10:23 volumio go-librespot[1824]: time="2025-06-30T19:10:23+02:00" level=trace msg="received dealer pong" Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 30 19:10:24 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 30 19:10:29 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 30 19:10:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 30 19:10:38 volumio volumio[847]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 30 19:10:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 30 19:10:38 volumio volumio[847]: info: Received Get System Version Jun 30 19:10:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 19:10:38 volumio volumio[847]: info: Received Get System Info Jun 30 19:10:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:10:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:10:38 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:10:38 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:38 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:10:41 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:10:41 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:10:41 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:10:41 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:10:41 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:10:53 volumio go-librespot[1824]: time="2025-06-30T19:10:53+02:00" level=trace msg="sent dealer ping" Jun 30 19:10:53 volumio go-librespot[1824]: time="2025-06-30T19:10:53+02:00" level=trace msg="received dealer pong" Jun 30 19:10:56 volumio volumio[847]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Jun 30 19:10:56 volumio sudo[15832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 19:10:56 volumio sudo[15832]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:10:56 volumio sudo[15832]: pam_unix(sudo:session): session closed for user root Jun 30 19:10:56 volumio volumio[847]: info: MPD Permissions set Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio sudo[15836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 19:10:56 volumio sudo[15836]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:10:56 volumio systemd[1]: Stopping Music Player Daemon... Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 30 19:10:56 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 19:10:56 volumio systemd[1]: mpd.service: Succeeded. Jun 30 19:10:56 volumio systemd[1]: Stopped Music Player Daemon. Jun 30 19:10:56 volumio systemd[1]: Starting Music Player Daemon... Jun 30 19:10:56 volumio sudo[15844]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 19:10:56 volumio sudo[15844]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:10:56 volumio sudo[15844]: pam_unix(sudo:session): session closed for user root Jun 30 19:10:57 volumio mpd[15847]: Jun 30 19:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 19:10:57 volumio systemd[1]: Started Music Player Daemon. Jun 30 19:10:57 volumio sudo[15836]: pam_unix(sudo:session): session closed for user root Jun 30 19:10:57 volumio volumio[847]: error: updateQueue error: null Jun 30 19:11:03 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:11:04 volumio sudo[15867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 19:11:04 volumio sudo[15867]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:11:04 volumio sudo[15867]: pam_unix(sudo:session): session closed for user root Jun 30 19:11:04 volumio sudo[15870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 19:11:04 volumio sudo[15870]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:11:04 volumio sudo[15870]: pam_unix(sudo:session): session closed for user root Jun 30 19:11:04 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 30 19:11:04 volumio sudo[15875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 19:11:04 volumio sudo[15875]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:11:04 volumio sudo[15875]: pam_unix(sudo:session): session closed for user root Jun 30 19:11:04 volumio sudo[15878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 19:11:04 volumio sudo[15878]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:11:04 volumio sudo[15878]: pam_unix(sudo:session): session closed for user root Jun 30 19:11:05 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.22 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 19:11:05 volumio volumio[847]: info: Received Get System Info Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:11:05 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:11:05 volumio volumio[847]: info: Listing playlists Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 30 19:11:05 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 30 19:11:06 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 30 19:11:06 volumio volumio[847]: info: Received Get System Info Jun 30 19:11:06 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:11:06 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:11:06 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:11:06 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:11:06 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:11:07 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 30 19:11:07 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 30 19:11:07 volumio volumio[847]: info: Received Get System Info Jun 30 19:11:07 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:11:07 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:11:07 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:11:07 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:11:07 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 19:11:08 volumio volumio[847]: info: Retrieving Cloud Streaming UI Jun 30 19:11:08 volumio volumio[847]: info: Getting Tidal Cloud Configuration Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 19:11:08 volumio volumio[847]: info: Getting Qobuz Cloud Configuration Jun 30 19:11:08 volumio volumio[847]: info: Asking plugin for UI Config Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 19:11:08 volumio volumio[847]: info: Getting Spotify Cloud Configuration Jun 30 19:11:08 volumio volumio[847]: info: Asking plugin for UI Config Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 19:11:08 volumio volumio[847]: info: Saving Spotify Acccount Jun 30 19:11:08 volumio volumio[847]: info: Got Tidal Cloud Configuration Jun 30 19:11:08 volumio volumio[847]: info: Got it Jun 30 19:11:08 volumio volumio[847]: info: Got it Jun 30 19:11:08 volumio volumio[847]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 19:11:08 volumio volumio[847]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::volumioGetBrowseSources Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::volumioGetBrowseSources Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::volumioGetBrowseSources Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 30 19:11:08 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 30 19:11:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 19:11:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 19:11:12 volumio volumio[847]: info: Discovery: Getting this device information Jun 30 19:11:12 volumio volumio[847]: info: CoreCommandRouter::volumioGetState Jun 30 19:11:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 19:11:12 volumio volumio[847]: info: Disabling MyMusic plugin upnp Jun 30 19:11:12 volumio sudo[15898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jun 30 19:11:12 volumio sudo[15898]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 19:11:12 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Jun 30 19:11:12 volumio volumio[847]: error: Upnp client error: Error: This socket has been ended by the other party Jun 30 19:11:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 30 19:11:14 volumio volumio[847]: info: Enabling MyMusic plugin upnp Jun 30 19:11:14 volumio volumio[847]: info: Enabling plugin upnp Jun 30 19:11:14 volumio volumio[847]: info: Loading plugin "upnp"... Jun 30 19:11:14 volumio volumio[847]: info: [1751303474802] Starting Upmpd Daemon Jun 30 19:11:14 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 19:11:14 volumio volumio[847]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 19:11:14 volumio volumio[847]: Error: listen EADDRINUSE: address already in use :::6599 Jun 30 19:11:14 volumio volumio[847]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Jun 30 19:11:14 volumio volumio[847]: at listenInCluster (net.js:1379:12) Jun 30 19:11:14 volumio volumio[847]: at Server.listen (net.js:1465:7) Jun 30 19:11:14 volumio volumio[847]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jun 30 19:11:14 volumio volumio[847]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jun 30 19:11:14 volumio volumio[847]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 30 19:11:14 volumio volumio[847]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 30 19:11:14 volumio volumio[847]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Jun 30 19:11:14 volumio volumio[847]: code: 'EADDRINUSE', Jun 30 19:11:14 volumio volumio[847]: errno: -98, Jun 30 19:11:14 volumio volumio[847]: syscall: 'listen', Jun 30 19:11:14 volumio volumio[847]: address: '::', Jun 30 19:11:14 volumio volumio[847]: port: 6599 Jun 30 19:11:14 volumio volumio[847]: } Jun 30 19:11:14 volumio volumio[847]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 19:11:14 volumio sudo[15912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 19:10 Jun 30 19:11:14 volumio sudo[15912]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"