Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 23:23:22 volumio volumio[996]: info: Discovery: Getting this device information Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:22 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 10 23:23:22 volumio sudo[2510]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 10 23:23:22 volumio sudo[2510]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:22 volumio sudo[2516]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 10 23:23:22 volumio sudo[2521]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 10 23:23:22 volumio sudo[2521]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:22 volumio sudo[2526]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 10 23:23:22 volumio sudo[2526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:22 volumio sudo[2516]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:22 volumio sudo[2510]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:22 volumio sudo[2516]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:22 volumio sudo[2521]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:22 volumio sudo[2526]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:22 volumio sudo[2541]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 10 23:23:22 volumio sudo[2540]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 23:23:22 volumio sudo[2540]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:22 volumio sudo[2541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:22 volumio sudo[2541]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:22 volumio sudo[2540]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 23:23:22 volumio volumio[996]: info: Discovery: Getting this device information Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:22 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:22 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 23:23:22 volumio volumio[996]: info: Discovery: Getting this device information Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:22 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 10 23:23:22 volumio volumio[996]: verbose: New Socket.io Connection to 192.168.1.247:3000 from 192.168.1.67 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 10 23:23:22 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 10 23:23:23 volumio sudo[2560]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 23:23:23 volumio sudo[2560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:23 volumio sudo[2561]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 10 23:23:23 volumio sudo[2561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:23 volumio sudo[2561]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:23 volumio sudo[2560]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:23 volumio volumio[996]: verbose: New Socket.io Connection to 192.168.1.247 from 192.168.1.67 UA: Mozilla/5.0 (Linux; Android 16; Pixel 9 Build/BP4A.251205.006.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 10 23:23:23 volumio sudo[2567]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 10 23:23:23 volumio sudo[2567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:23 volumio sudo[2569]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 23:23:23 volumio sudo[2569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:23 volumio sudo[2567]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:23 volumio sudo[2569]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:23 volumio volumio[996]: verbose: New Socket.io Connection to 192.168.1.247 from 192.168.1.67 UA: Mozilla/5.0 (Linux; Android 16; Pixel 9 Build/BP4A.251205.006.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::volumioGetVisibleSources Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:23 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 10 23:23:23 volumio volumio[996]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 10 23:23:23 volumio volumio[996]: info: Received Get System Info Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 23:23:23 volumio volumio[996]: info: Discovery: Getting this device information Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:23 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:23 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:23 volumio volumio[996]: info: Listing playlists Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 10 23:23:23 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 10 23:23:25 volumio volumio[996]: info: Received Get System Info Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 23:23:25 volumio volumio[996]: info: Discovery: Getting this device information Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:25 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:25 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::volumioPlay Dec 10 23:23:25 volumio volumio[996]: info: CoreStateMachine::play index undefined Dec 10 23:23:25 volumio volumio[996]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 23:23:25 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:25 volumio volumio[996]: info: CoreStateMachine::startPlaybackTimer Dec 10 23:23:25 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:25 volumio volumio[996]: info: ControllerMpd::resume Dec 10 23:23:25 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand play Dec 10 23:23:25 volumio volumio[996]: info: Dec 10 23:23:25 volumio volumio[996]: ---------------------------- MPD announces state update: player Dec 10 23:23:25 volumio volumio[996]: info: sendMpdCommand play took 9 milliseconds Dec 10 23:23:25 volumio volumio[996]: info: ControllerMpd::getState Dec 10 23:23:25 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Dec 10 23:23:25 volumio volumio[996]: info: sendMpdCommand status took 0 milliseconds Dec 10 23:23:25 volumio volumio[996]: verbose: ControllerMpd::parseState Dec 10 23:23:25 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 23:23:25 volumio volumio[996]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 10 23:23:25 volumio volumio[996]: verbose: ControllerMpd::parseTrackInfo Dec 10 23:23:25 volumio volumio[996]: info: ControllerMpd::pushState Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::servicePushState Dec 10 23:23:25 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:25 volumio volumio[996]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22241,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"762 Kbps","isStreaming":false,"title":"Cotton Club (Feat. Jeff Lorber)","artist":"Chuck Loeb","album":"Unspoken","uri":"NAS/Old/_HiRes/2016 - Unspoken/01 - Cotton Club (Feat. Jeff Lorber).flac","trackType":"flac"} Dec 10 23:23:25 volumio volumio[996]: verbose: CURRENT POSITION 0 Dec 10 23:23:25 volumio volumio[996]: info: CoreStateMachine::syncState stateService play Dec 10 23:23:25 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus pause Dec 10 23:23:25 volumio volumio[996]: info: CoreStateMachine::pushState Dec 10 23:23:25 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 23:23:25 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Dec 10 23:23:25 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Dec 10 23:23:25 volumio volumio[996]: info: MRS: Pushing multiroomSync output Dec 10 23:23:25 volumio volumio[996]: info: ------------------------------ 6ms Dec 10 23:23:26 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 10 23:23:26 volumio volumio[996]: info: Received Get System Info Dec 10 23:23:26 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 23:23:26 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 23:23:26 volumio volumio[996]: info: Discovery: Getting this device information Dec 10 23:23:26 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:26 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:26 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 10 23:23:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 10 23:23:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 10 23:23:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 10 23:23:41 volumio volumio[996]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 10 23:23:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 10 23:23:41 volumio volumio[996]: info: Received Get System Version Dec 10 23:23:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 10 23:23:41 volumio volumio[996]: info: Received Get System Info Dec 10 23:23:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 23:23:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 23:23:41 volumio volumio[996]: info: Discovery: Getting this device information Dec 10 23:23:41 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:41 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 10 23:23:46 volumio volumio[996]: info: CoreCommandRouter::volumioPause Dec 10 23:23:46 volumio volumio[996]: info: CoreStateMachine::pause Dec 10 23:23:46 volumio volumio[996]: info: CoreStateMachine::stPlaybackTimer Dec 10 23:23:46 volumio volumio[996]: info: CoreStateMachine::servicePause Dec 10 23:23:46 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:46 volumio volumio[996]: info: CoreCommandRouter::servicePause Dec 10 23:23:46 volumio volumio[996]: info: ControllerMpd::pause Dec 10 23:23:46 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand pause Dec 10 23:23:46 volumio volumio[996]: info: Dec 10 23:23:46 volumio volumio[996]: ---------------------------- MPD announces state update: player Dec 10 23:23:46 volumio volumio[996]: info: sendMpdCommand pause took 5 milliseconds Dec 10 23:23:46 volumio volumio[996]: info: ControllerMpd::getState Dec 10 23:23:46 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Dec 10 23:23:46 volumio volumio[996]: info: sendMpdCommand status took 0 milliseconds Dec 10 23:23:46 volumio volumio[996]: verbose: ControllerMpd::parseState Dec 10 23:23:46 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 23:23:46 volumio volumio[996]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 10 23:23:46 volumio volumio[996]: verbose: ControllerMpd::parseTrackInfo Dec 10 23:23:46 volumio volumio[996]: info: ControllerMpd::pushState Dec 10 23:23:46 volumio volumio[996]: info: CoreCommandRouter::servicePushState Dec 10 23:23:46 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:46 volumio volumio[996]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":43159,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"Cotton Club (Feat. Jeff Lorber)","artist":"Chuck Loeb","album":"Unspoken","uri":"NAS/Old/_HiRes/2016 - Unspoken/01 - Cotton Club (Feat. Jeff Lorber).flac","trackType":"flac"} Dec 10 23:23:46 volumio volumio[996]: verbose: CURRENT POSITION 0 Dec 10 23:23:46 volumio volumio[996]: info: CoreStateMachine::syncState stateService pause Dec 10 23:23:46 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus pause Dec 10 23:23:46 volumio volumio[996]: info: CoreStateMachine::pushState Dec 10 23:23:46 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:46 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 23:23:46 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Dec 10 23:23:46 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Dec 10 23:23:46 volumio volumio[996]: info: MRS: Pushing multiroomSync output Dec 10 23:23:46 volumio volumio[996]: info: CoreStateMachine::stPlaybackTimer Dec 10 23:23:46 volumio volumio[996]: info: ------------------------------ 5ms Dec 10 23:23:47 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Dec 10 23:23:47 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 10 23:23:47 volumio volumio[996]: info: CoreCommandRouter::volumioPlay Dec 10 23:23:47 volumio volumio[996]: info: CoreStateMachine::play index undefined Dec 10 23:23:47 volumio volumio[996]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 23:23:47 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:47 volumio volumio[996]: info: CoreStateMachine::startPlaybackTimer Dec 10 23:23:47 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:47 volumio volumio[996]: info: ControllerMpd::resume Dec 10 23:23:47 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand play Dec 10 23:23:47 volumio volumio[996]: info: Dec 10 23:23:47 volumio volumio[996]: ---------------------------- MPD announces state update: player Dec 10 23:23:47 volumio volumio[996]: info: sendMpdCommand play took 6 milliseconds Dec 10 23:23:47 volumio volumio[996]: info: ControllerMpd::getState Dec 10 23:23:47 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Dec 10 23:23:47 volumio volumio[996]: info: sendMpdCommand status took 1 milliseconds Dec 10 23:23:47 volumio volumio[996]: verbose: ControllerMpd::parseState Dec 10 23:23:47 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 23:23:47 volumio volumio[996]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 10 23:23:47 volumio volumio[996]: verbose: ControllerMpd::parseTrackInfo Dec 10 23:23:47 volumio volumio[996]: info: ControllerMpd::pushState Dec 10 23:23:47 volumio volumio[996]: info: CoreCommandRouter::servicePushState Dec 10 23:23:47 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:47 volumio volumio[996]: verbose: STATE SERVICE {"status":"play","position":0,"seek":43342,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"Cotton Club (Feat. Jeff Lorber)","artist":"Chuck Loeb","album":"Unspoken","uri":"NAS/Old/_HiRes/2016 - Unspoken/01 - Cotton Club (Feat. Jeff Lorber).flac","trackType":"flac"} Dec 10 23:23:47 volumio volumio[996]: verbose: CURRENT POSITION 0 Dec 10 23:23:47 volumio volumio[996]: info: CoreStateMachine::syncState stateService play Dec 10 23:23:47 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus pause Dec 10 23:23:47 volumio volumio[996]: info: CoreStateMachine::pushState Dec 10 23:23:47 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Dec 10 23:23:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 23:23:47 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Dec 10 23:23:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Dec 10 23:23:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output Dec 10 23:23:47 volumio volumio[996]: info: ------------------------------ 6ms Dec 10 23:23:59 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 10 23:23:59 volumio volumio[996]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Dec 10 23:23:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 10 23:23:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 10 23:23:59 volumio sudo[2671]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 10 23:23:59 volumio sudo[2671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio sudo[2671]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:59 volumio sudo[2678]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 10 23:23:59 volumio sudo[2678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio sudo[2676]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 10 23:23:59 volumio sudo[2676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio sudo[2693]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 10 23:23:59 volumio sudo[2693]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio sudo[2689]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 10 23:23:59 volumio sudo[2689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 10 23:23:59 volumio sudo[2693]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 10 23:23:59 volumio sudo[2676]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:59 volumio sudo[2678]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:59 volumio sudo[2712]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 10 23:23:59 volumio sudo[2712]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio sudo[2705]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 10 23:23:59 volumio sudo[2705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio sudo[2712]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:59 volumio volumio[996]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 10 23:23:59 volumio volumio[996]: wlan0 Interface doesn't support scanning. Dec 10 23:23:59 volumio sudo[2705]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:59 volumio volumio[996]: info: Cannot use regular scanning, forcing with ap-force Dec 10 23:23:59 volumio sudo[2723]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 10 23:23:59 volumio sudo[2723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:23:59 volumio sudo[2723]: pam_unix(sudo:session): session closed for user root Dec 10 23:23:59 volumio volumio[996]: command failed: No such device (-19) Dec 10 23:23:59 volumio volumio[996]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 10 23:23:59 volumio volumio[996]: command failed: No such device (-19) Dec 10 23:23:59 volumio sudo[2689]: pam_unix(sudo:session): session closed for user root Dec 10 23:24:33 volumio volumio[996]: info: CALLMETHOD: system_controller network saveDnsSettings [object Object] Dec 10 23:24:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , saveDnsSettings Dec 10 23:24:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 10 23:24:33 volumio volumio[996]: info: Discovery: Restarting Advertising due to device name change Dec 10 23:24:33 volumio sudo[2827]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/resolv.conf.tail Dec 10 23:24:33 volumio sudo[2827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:24:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 10 23:24:33 volumio volumio[996]: info: Discovery: Restarting Advertising due to device name change Dec 10 23:24:33 volumio sudo[2827]: pam_unix(sudo:session): session closed for user root Dec 10 23:24:33 volumio sudo[2829]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 10 23:24:33 volumio sudo[2829]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:24:33 volumio sudo[2832]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0 Dec 10 23:24:33 volumio sudo[2832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:24:33 volumio avahi-daemon[737]: Withdrawing address record for 192.168.1.247 on eth0. Dec 10 23:24:33 volumio avahi-daemon[737]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.247. Dec 10 23:24:33 volumio dhcpcd[748]: eth0: pid 2834 deleted IP address 192.168.1.247/24 Dec 10 23:24:33 volumio dhcpcd[748]: eth0: deleting route to 192.168.1.0/24 Dec 10 23:24:33 volumio avahi-daemon[737]: Interface eth0.IPv4 no longer relevant for mDNS. Dec 10 23:24:33 volumio dhcpcd[804]: eth0: pid 2834 deleted IP address 192.168.1.247/24 Dec 10 23:24:33 volumio dhcpcd[804]: eth0: deleting route to 192.168.1.0/24 Dec 10 23:24:33 volumio dhcpcd[804]: eth0: deleting default route via 192.168.1.1 Dec 10 23:24:33 volumio dhcpcd[748]: eth0: deleting default route via 192.168.1.1 Dec 10 23:24:33 volumio sudo[2832]: pam_unix(sudo:session): session closed for user root Dec 10 23:24:33 volumio volumio[996]: info: Discovery: A device disappeared from network Dec 10 23:24:33 volumio volumio[996]: info: Discovery: Device volumio disappeared from network Dec 10 23:24:33 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Dec 10 23:24:33 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Dec 10 23:24:33 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 10 23:24:33 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 10 23:24:33 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 10 23:24:33 volumio dhcpcd[804]: eth0: rebinding lease of 192.168.1.247 Dec 10 23:24:33 volumio dhcpcd[748]: eth0: rebinding lease of 192.168.1.247 Dec 10 23:24:33 volumio sudo[2843]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down Dec 10 23:24:33 volumio sudo[2843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:24:33 volumio dhcpcd[804]: eth0: carrier lost Dec 10 23:24:33 volumio dhcpcd[748]: eth0: carrier lost Dec 10 23:24:33 volumio sudo[2843]: pam_unix(sudo:session): session closed for user root Dec 10 23:24:33 volumio sudo[2862]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up Dec 10 23:24:33 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 10 23:24:33 volumio sudo[2862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 10 23:24:33 volumio kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Dec 10 23:24:33 volumio sudo[2862]: pam_unix(sudo:session): session closed for user root Dec 10 23:24:33 volumio welcome[2851]: Resolved ip:[0] Dec 10 23:24:33 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 10 23:24:33 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 10 23:24:33 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 10 23:24:33 volumio dhcpcd[804]: eth0: probing address 192.168.1.247/24 Dec 10 23:24:33 volumio dhcpcd[748]: eth0: probing address 192.168.1.247/24 Dec 10 23:24:33 volumio wireless.js[2877]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 10 23:24:33 volumio wireless.js[2877]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 10 23:24:33 volumio wireless.js[2877]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 10 23:24:33 volumio wireless.js[2877]: WIRELESS.JS: Cleaning previous... Dec 10 23:24:33 volumio wireless.js[2877]: WIRELESS.JS: No wireless interface, exiting Dec 10 23:24:33 volumio dhcpcd[748]: eth0: carrier acquired Dec 10 23:24:33 volumio dhcpcd[804]: eth0: carrier acquired Dec 10 23:24:33 volumio dhcpcd[804]: eth0: IAID 00:53:f3:9e Dec 10 23:24:33 volumio systemd[1]: wireless.service: Failed with result 'protocol'. Dec 10 23:24:33 volumio dhcpcd[748]: eth0: IAID 00:53:f3:9e Dec 10 23:24:33 volumio systemd[1]: Failed to start wireless.service - Wireless Services. Dec 10 23:24:33 volumio sudo[2829]: pam_unix(sudo:session): session closed for user root Dec 10 23:24:34 volumio dhcpcd[804]: eth0: soliciting an IPv6 router Dec 10 23:24:34 volumio dhcpcd[748]: eth0: rebinding lease of 192.168.1.247 Dec 10 23:24:34 volumio dhcpcd[748]: eth0: probing address 192.168.1.247/24 Dec 10 23:24:34 volumio dhcpcd[804]: eth0: rebinding lease of 192.168.1.247 Dec 10 23:24:34 volumio dhcpcd[804]: eth0: probing address 192.168.1.247/24 Dec 10 23:24:34 volumio dhcpcd[748]: eth0: soliciting an IPv6 router Dec 10 23:24:34 volumio volumio[996]: info: Discovery: A device disappeared from network Dec 10 23:24:35 volumio ntpd[867]: IO: Deleting interface #3 eth0, 192.168.1.247#123, interface stats: received=187, sent=203, dropped=1, active_time=369 secs Dec 10 23:24:35 volumio ntpd[867]: PROTO: 51.68.141.5 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 194.146.251.101 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 149.156.70.60 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 94.154.96.7 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 194.146.251.114 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 194.146.251.102 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 94.240.10.55 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 46.175.224.7 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 195.46.37.22 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 178.215.228.24 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 212.127.95.218 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 212.127.78.21 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 193.70.94.182 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 193.59.134.156 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 162.159.200.123 unlink local addr 192.168.1.247 -> Dec 10 23:24:35 volumio ntpd[867]: PROTO: 156.17.245.123 unlink local addr 192.168.1.247 -> Dec 10 23:24:38 volumio volumio[996]: info: Discovery: Started advertising with name: Volumio Dec 10 23:24:38 volumio volumio[996]: info: Discovery: Started advertising with name: Volumio Dec 10 23:24:38 volumio dhcpcd[748]: eth0: leased 192.168.1.247 for 8640000 seconds Dec 10 23:24:38 volumio avahi-daemon[737]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.247. Dec 10 23:24:38 volumio dhcpcd[748]: eth0: adding route to 192.168.1.0/24 Dec 10 23:24:38 volumio avahi-daemon[737]: New relevant interface eth0.IPv4 for mDNS. Dec 10 23:24:38 volumio avahi-daemon[737]: Registering new address record for 192.168.1.247 on eth0.IPv4. Dec 10 23:24:38 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Dec 10 23:24:38 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Dec 10 23:24:38 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 10 23:24:38 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 10 23:24:38 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 10 23:24:38 volumio dhcpcd[748]: eth0: adding default route via 192.168.1.1 Dec 10 23:24:38 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 10 23:24:38 volumio welcome[2936]: Resolved ip:[1] 192.168.1.247 Dec 10 23:24:38 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 10 23:24:38 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 10 23:24:38 volumio volumio[996]: info: MRS: Found cast device: SHIELD-Android-TV-8bca3b0dab941ba2e72448bf813ab4dd Dec 10 23:24:38 volumio volumio[996]: compat.c: read() failed: Resource temporarily unavailable Dec 10 23:24:38 volumio volumio[996]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 23:24:38 volumio volumio[996]: Error: dns service error: unknown Dec 10 23:24:38 volumio volumio[996]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 10 23:24:38 volumio volumio[996]: errorCode: -65537 Dec 10 23:24:38 volumio volumio[996]: } Dec 10 23:24:38 volumio volumio[996]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 23:24:38 volumio sudo[2975]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-10 23:23' Dec 10 23:24:38 volumio sudo[2975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"