-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2025-06-27 13:18:16 CEST. -- Jun 27 13:17:17 raspberry-pi-4 kernel: usb 1-1.1: new high-speed USB device number 4 using dwc_otg Jun 27 13:17:17 raspberry-pi-4 kernel: usb 1-1.1: New USB device found, idVendor=05e3, idProduct=0727, bcdDevice= 2.50 Jun 27 13:17:17 raspberry-pi-4 kernel: usb 1-1.1: New USB device strings: Mfr=3, Product=4, SerialNumber=2 Jun 27 13:17:17 raspberry-pi-4 kernel: usb 1-1.1: Product: USB Storage Jun 27 13:17:17 raspberry-pi-4 kernel: usb 1-1.1: Manufacturer: Generic Jun 27 13:17:17 raspberry-pi-4 kernel: usb 1-1.1: SerialNumber: 000000000250 Jun 27 13:17:17 raspberry-pi-4 kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Jun 27 13:17:17 raspberry-pi-4 kernel: scsi host0: usb-storage 1-1.1:1.0 Jun 27 13:17:18 raspberry-pi-4 kernel: scsi 0:0:0:0: Direct-Access Generic STORAGE DEVICE 0250 PQ: 0 ANSI: 0 Jun 27 13:17:19 raspberry-pi-4 kernel: sd 0:0:0:0: [sda] 249737216 512-byte logical blocks: (128 GB/119 GiB) Jun 27 13:17:19 raspberry-pi-4 kernel: sd 0:0:0:0: [sda] Write Protect is off Jun 27 13:17:19 raspberry-pi-4 kernel: sd 0:0:0:0: [sda] Mode Sense: 0b 00 00 08 Jun 27 13:17:19 raspberry-pi-4 kernel: sd 0:0:0:0: [sda] No Caching mode page found Jun 27 13:17:19 raspberry-pi-4 kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Jun 27 13:17:19 raspberry-pi-4 kernel: sda: sda1 Jun 27 13:17:19 raspberry-pi-4 kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Jun 27 13:17:19 raspberry-pi-4 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jun 27 13:17:19 raspberry-pi-4 volumio[805]: info: Mounting Device Volume Jun 27 13:17:19 raspberry-pi-4 sudo[10275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Volume -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 27 13:17:19 raspberry-pi-4 sudo[10275]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:25 raspberry-pi-4 ntfs-3g[10293]: Version 2017.3.23AR.3 integrated FUSE 28 Jun 27 13:17:25 raspberry-pi-4 ntfs-3g[10293]: Mounted /dev/sda1 (Read-Write, label "Volume", NTFS 3.1) Jun 27 13:17:25 raspberry-pi-4 ntfs-3g[10293]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 27 13:17:25 raspberry-pi-4 ntfs-3g[10293]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jun 27 13:17:25 raspberry-pi-4 ntfs-3g[10293]: Global ownership and permissions enforced, configuration type 7 Jun 27 13:17:25 raspberry-pi-4 sudo[10275]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:25 raspberry-pi-4 volumio[805]: The disk contains an unclean file system (0, 0). Jun 27 13:17:25 raspberry-pi-4 volumio[805]: The file system wasn't safely closed on Windows. Fixing. Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: Scanning new location : "USB/Volume" Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:25 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: update Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 5 milliseconds Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 4 milliseconds Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: Command Router : Notfying DB Updatetrue Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:25 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:25 raspberry-pi-4 volumio[805]: info: ------------------------------ 105ms Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: MPD Database updated - AlbumList cache refreshed Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:31 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: database Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:31 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: update Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 116 milliseconds Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 114 milliseconds Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 113 milliseconds Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: Command Router : Notfying DB Updatefalse Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::Close All Modals sent Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:31 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: ------------------------------ 220ms Jun 27 13:17:31 raspberry-pi-4 volumio[805]: info: ------------------------------ 220ms Jun 27 13:17:36 raspberry-pi-4 sudo[10322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 13:17:36 raspberry-pi-4 sudo[10320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 13:17:36 raspberry-pi-4 sudo[10320]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:36 raspberry-pi-4 sudo[10322]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:36 raspberry-pi-4 sudo[10320]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:36 raspberry-pi-4 sudo[10322]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:36 raspberry-pi-4 volumio[805]: verbose: New Socket.io Connection to 192.168.6.218 from 192.168.6.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Edg/137.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 13:17:36 raspberry-pi-4 sudo[10328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 13:17:36 raspberry-pi-4 sudo[10328]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:36 raspberry-pi-4 sudo[10328]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:36 raspberry-pi-4 sudo[10331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 13:17:36 raspberry-pi-4 sudo[10331]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:36 raspberry-pi-4 sudo[10331]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:36 raspberry-pi-4 volumio[805]: verbose: New Socket.io Connection to 192.168.6.218 from 192.168.6.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Edg/137.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: Listing playlists Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 13:17:36 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 13:17:38 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 13:17:38 raspberry-pi-4 volumio[805]: info: Received Get System Info Jun 27 13:17:38 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 13:17:38 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 13:17:38 raspberry-pi-4 volumio[805]: info: Discovery: Getting this device information Jun 27 13:17:38 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:38 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Retrieving Cloud Streaming UI Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Getting Tidal Cloud Configuration Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Getting Qobuz Cloud Configuration Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Asking plugin for UI Config Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Getting Spotify Cloud Configuration Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Asking plugin for UI Config Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Saving Spotify Acccount Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Got it Jun 27 13:17:39 raspberry-pi-4 volumio[805]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Got Tidal Cloud Configuration Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Got it Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetBrowseSources Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetBrowseSources Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetBrowseSources Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Received Get System Info Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: Discovery: Getting this device information Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:39 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand update Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:43 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: update Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: sendMpdCommand update took 6 milliseconds Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 6 milliseconds Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 3 milliseconds Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: Command Router : Notfying DB Updatetrue Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::Close All Modals sent Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 10 milliseconds Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:43 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: ------------------------------ 118ms Jun 27 13:17:43 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:44 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: update Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 3 milliseconds Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 1 milliseconds Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: Command Router : Notfying DB Updatefalse Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::Close All Modals sent Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:44 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:44 raspberry-pi-4 volumio[805]: info: ------------------------------ 80ms Jun 27 13:17:47 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand rescan Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:50 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: update Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: sendMpdCommand rescan took 6 milliseconds Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 6 milliseconds Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 3 milliseconds Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: Command Router : Notfying DB Updatetrue Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::Close All Modals sent Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:50 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:50 raspberry-pi-4 volumio[805]: info: ------------------------------ 123ms Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: MPD Database updated - AlbumList cache refreshed Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:51 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: database Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: Jun 27 13:17:51 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: update Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: ControllerMpd::getState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand status Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 48 milliseconds Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: sendMpdCommand status took 48 milliseconds Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: Command Router : Notfying DB Updatefalse Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::Close All Modals sent Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::parseTrackInfo Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: ControllerMpd::pushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::servicePushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":77097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1499 Kbps","isStreaming":false,"title":"176446848","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/176446848","trackType":"qobuz"} Jun 27 13:17:51 raspberry-pi-4 volumio[805]: verbose: CURRENT POSITION 5 Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState stateService pause Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::syncState currentStatus pause Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: ------------------------------ 131ms Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: ------------------------------ 131ms Jun 27 13:17:51 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 27 13:17:54 raspberry-pi-4 sudo[10374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 13:17:54 raspberry-pi-4 sudo[10374]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:54 raspberry-pi-4 sudo[10374]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:54 raspberry-pi-4 sudo[10377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 13:17:54 raspberry-pi-4 sudo[10377]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:54 raspberry-pi-4 sudo[10377]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:54 raspberry-pi-4 volumio[805]: verbose: New Socket.io Connection to 192.168.6.218 from 192.168.6.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Edg/137.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 13:17:54 raspberry-pi-4 sudo[10385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 13:17:54 raspberry-pi-4 sudo[10385]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:54 raspberry-pi-4 sudo[10385]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:54 raspberry-pi-4 sudo[10388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 13:17:54 raspberry-pi-4 sudo[10388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:54 raspberry-pi-4 sudo[10388]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:54 raspberry-pi-4 volumio[805]: verbose: New Socket.io Connection to 192.168.6.218 from 192.168.6.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Edg/137.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: Listing playlists Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 13:17:54 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 13:17:56 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 13:17:56 raspberry-pi-4 volumio[805]: info: Received Get System Info Jun 27 13:17:56 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 13:17:56 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 13:17:56 raspberry-pi-4 volumio[805]: info: Discovery: Getting this device information Jun 27 13:17:56 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:56 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 13:17:56 raspberry-pi-4 volumiologrotate[512]: ls: cannot access '/var/log/samba/log.wb-RASPBERRY': No such file or directory Jun 27 13:17:56 raspberry-pi-4 volumiologrotate[512]: ls: cannot access 'PI': No such file or directory Jun 27 13:17:56 raspberry-pi-4 volumiologrotate[512]: ls: cannot access '4': No such file or directory Jun 27 13:17:56 raspberry-pi-4 sudo[10438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 13:17:56 raspberry-pi-4 sudo[10438]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:56 raspberry-pi-4 sudo[10438]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:56 raspberry-pi-4 sudo[10441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 13:17:56 raspberry-pi-4 sudo[10441]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:56 raspberry-pi-4 sudo[10441]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:56 raspberry-pi-4 volumio[805]: verbose: New Socket.io Connection to 192.168.6.218 from 192.168.6.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Edg/137.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Jun 27 13:17:57 raspberry-pi-4 sudo[10446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 13:17:57 raspberry-pi-4 sudo[10446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:57 raspberry-pi-4 sudo[10446]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:57 raspberry-pi-4 sudo[10449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 13:17:57 raspberry-pi-4 sudo[10449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 13:17:57 raspberry-pi-4 sudo[10449]: pam_unix(sudo:session): session closed for user root Jun 27 13:17:57 raspberry-pi-4 volumio[805]: verbose: New Socket.io Connection to 192.168.6.218 from 192.168.6.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Edg/137.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: Listing playlists Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 13:17:57 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 13:17:58 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 13:17:58 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 13:17:58 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetQueue Jun 27 13:17:58 raspberry-pi-4 volumio[805]: info: CoreStateMachine::getQueue Jun 27 13:17:58 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getQueue Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: Received Get System Info Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: Discovery: Getting this device information Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: CURURI: music-library Jun 27 13:17:59 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:00 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 13:18:00 raspberry-pi-4 volumio[805]: info: Received Get System Info Jun 27 13:18:00 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 13:18:00 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 13:18:00 raspberry-pi-4 volumio[805]: info: Discovery: Getting this device information Jun 27 13:18:00 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:18:00 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 13:18:01 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 13:18:01 raspberry-pi-4 volumio[805]: info: CURURI: music-library/USB Jun 27 13:18:01 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:02 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 13:18:02 raspberry-pi-4 volumio[805]: info: CURURI: music-library/USB/Volume Jun 27 13:18:02 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:07 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 13:18:07 raspberry-pi-4 volumio[805]: info: CURURI: music-library/USB/Volume/Hoff Ensemle Jun 27 13:18:07 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:11 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 13:18:11 raspberry-pi-4 volumio[805]: info: CURURI: music-library/USB/Volume/Hoff Ensemle/Polarity Jun 27 13:18:11 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: CURURI: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_01_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_02_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_03_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_04_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_05_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_06_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_07_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_08_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_09_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_10_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_11_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Preloading song: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_12_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_01_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_01_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_01_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_02_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_02_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_02_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_03_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_03_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_03_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_04_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_04_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_04_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_05_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_05_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_05_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_06_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_06_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_06_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_07_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_07_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_07_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_08_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_08_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_08_FLAC_88k_24b.wav Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_09_FLAC_88k_24b.wav in service mpd Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_09_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:12 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_09_FLAC_88k_24b.wav Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_10_FLAC_88k_24b.wav in service mpd Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_10_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_10_FLAC_88k_24b.wav Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_11_FLAC_88k_24b.wav in service mpd Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_11_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_11_FLAC_88k_24b.wav Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_12_FLAC_88k_24b.wav in service mpd Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%20/Polarity/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2F2L-45_stereo_12_FLAC_88k_24b.wav&metadata=false Jun 27 13:18:13 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_12_FLAC_88k_24b.wav Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: Received Get System Version Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: Received Get System Info Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: Discovery: Getting this device information Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::ClearQueue Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stop Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::updateTrackBlock Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrackBlock Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stPlaybackTimer Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::pushState Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushState Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetState Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::serviceStop Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 5 Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::serviceStop Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: [1751023095967] ControllerQobuz::stop Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: ControllerMpd::stop Jun 27 13:18:15 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CorePlayQueue::clearPlayQueue Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CorePlayQueue::saveQueue Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushQueue Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CoreStateMachine::addQueueItems Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: CorePlayQueue::addQueueItems Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_01_FLAC_88k_24b.wav Jun 27 13:18:15 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_01_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPushQueue Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CorePlayQueue::saveQueue Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::updateTrackBlock Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrackBlock Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioPlay Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::play index 0 Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::addQueueItems Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CorePlayQueue::addQueueItems Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Preload queue cleared Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_02_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_02_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_03_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_03_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_04_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_04_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_05_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_05_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_06_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_06_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_07_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_07_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_08_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_08_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_09_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_09_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_10_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_10_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_11_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_11_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_12_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Using cached record of: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_12_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Adding Item to queue: music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/full_album_flac_88.zip Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Exploding uri music-library/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/full_album_flac_88.zip in service mpd Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::stop Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::play index undefined Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 0 Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreStateMachine::startPlaybackTimer Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CorePlayQueue::getTrack 0 Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 27 13:18:16 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::clearAddPlayTracks USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/2L-45_stereo_01_FLAC_88k_24b.wav Jun 27 13:18:16 raspberry-pi-4 volumio[805]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: Jun 27 13:18:16 raspberry-pi-4 volumio[805]: ---------------------------- MPD announces state update: player Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%3A%20Jan%20Gunnar%20Hoff%2C%20Audun%20Kleive%20%26%20Anders%20Jormin/POLARITY%20%E2%80%94%20an%20acoustic%20jazz%20project/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2Ffull_album_flac_88.zip&metadata=false Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/full_album_flac_88.zip Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: ALBUMART /albumart?cacheid=710&web=Hoff%20Ensemble%3A%20Jan%20Gunnar%20Hoff%2C%20Audun%20Kleive%20%26%20Anders%20Jormin/POLARITY%20%E2%80%94%20an%20acoustic%20jazz%20project/extralarge&path=%2Fmnt%2FUSB%2FVolume%2FHoff%20Ensemle%2FPolarity%2FPolarity%2088%2C2k%2Ffull_album_flac_88.zip&metadata=false Jun 27 13:18:16 raspberry-pi-4 volumio[805]: info: URI /mnt/USB/Volume/Hoff Ensemle/Polarity/Polarity 88,2k/full_album_flac_88.zip Jun 27 13:18:16 raspberry-pi-4 volumio[805]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 13:18:16 raspberry-pi-4 volumio[805]: Error: Unable to resolve or reject the same promise twice Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at Socket.emit (events.js:315:20) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at addChunk (internal/streams/readable.js:309:12) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at readableAddChunk (internal/streams/readable.js:280:11) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jun 27 13:18:16 raspberry-pi-4 volumio[805]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 13:18:16 raspberry-pi-4 sudo[10494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 13:17 Jun 27 13:18:16 raspberry-pi-4 sudo[10494]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"