-- Logs begin at Thu 2025-05-22 13:46:47 CEST, end at Thu 2025-05-22 14:12:09 CEST. -- May 22 14:11:05 volumio kernel: usb 2-5: new SuperSpeed USB device number 3 using xhci_hcd May 22 14:11:05 volumio kernel: usb 2-5: New USB device found, idVendor=090c, idProduct=1000, bcdDevice=11.00 May 22 14:11:05 volumio kernel: usb 2-5: New USB device strings: Mfr=1, Product=2, SerialNumber=3 May 22 14:11:05 volumio kernel: usb 2-5: Product: Flash Drive May 22 14:11:05 volumio kernel: usb 2-5: Manufacturer: Samsung May 22 14:11:05 volumio kernel: usb 2-5: SerialNumber: 0363723090001329 May 22 14:11:05 volumio kernel: usb-storage 2-5:1.0: USB Mass Storage device detected May 22 14:11:05 volumio kernel: scsi host7: usb-storage 2-5:1.0 May 22 14:11:06 volumio kernel: scsi 7:0:0:0: Direct-Access Samsung Flash Drive 1100 PQ: 0 ANSI: 6 May 22 14:11:06 volumio kernel: scsi 7:0:0:0: Attached scsi generic sg1 type 0 May 22 14:11:06 volumio kernel: sd 7:0:0:0: [sdc] 250626566 512-byte logical blocks: (128 GB/120 GiB) May 22 14:11:06 volumio kernel: sd 7:0:0:0: [sdc] Write Protect is off May 22 14:11:06 volumio kernel: sd 7:0:0:0: [sdc] Mode Sense: 43 00 00 00 May 22 14:11:06 volumio kernel: sd 7:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA May 22 14:11:06 volumio kernel: sdc: sdc1 sdc2 May 22 14:11:06 volumio kernel: sd 7:0:0:0: [sdc] Attached SCSI removable disk May 22 14:11:06 volumio volumio[878]: info: Mounting Device EFI May 22 14:11:06 volumio sudo[6729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 22 14:11:06 volumio sudo[6729]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:06 volumio kernel: FAT-fs (sdc1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 22 14:11:06 volumio sudo[6729]: pam_unix(sudo:session): session closed for user root May 22 14:11:06 volumio volumio[878]: info: Mounting Device PenDrive May 22 14:11:06 volumio volumio[878]: /bin/mkdir: cannot create directory ‘/mnt/USB/PenDrive’: File exists May 22 14:11:06 volumio volumio[878]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/PenDrive" May 22 14:11:06 volumio volumio[878]: /bin/mkdir: cannot create directory ‘/mnt/USB/PenDrive’: File exists May 22 14:11:06 volumio sudo[6738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc2 /mnt/USB/PenDrive -o noatime May 22 14:11:06 volumio sudo[6738]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:06 volumio mount.exfat[6740]: volume was not unmounted cleanly May 22 14:11:06 volumio sudo[6738]: pam_unix(sudo:session): session closed for user root May 22 14:11:06 volumio volumio[878]: WARN: volume was not unmounted cleanly. May 22 14:11:06 volumio volumio[878]: fuse: bad mount point `/mnt/USB/PenDrive': Transport endpoint is not connected May 22 14:11:06 volumio volumio[878]: error: Failed to mount PenDrive: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc2" "/mnt/USB/PenDrive" -o noatime May 22 14:11:06 volumio volumio[878]: WARN: volume was not unmounted cleanly. May 22 14:11:06 volumio volumio[878]: fuse: bad mount point `/mnt/USB/PenDrive': Transport endpoint is not connected May 22 14:11:06 volumio volumio[878]: info: Scanning new location : "USB/EFI" May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: info: May 22 14:11:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:11:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: info: May 22 14:11:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:11:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: info: May 22 14:11:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:11:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: info: May 22 14:11:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:11:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:06 volumio volumio[878]: info: sendMpdCommand status took 1 milliseconds May 22 14:11:06 volumio volumio[878]: info: sendMpdCommand status took 0 milliseconds May 22 14:11:06 volumio volumio[878]: info: sendMpdCommand status took 0 milliseconds May 22 14:11:06 volumio volumio[878]: info: sendMpdCommand status took 1 milliseconds May 22 14:11:06 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:07 volumio volumio[878]: info: May 22 14:11:07 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:07 volumio volumio[878]: info: May 22 14:11:07 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand status took 174 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand status took 174 milliseconds May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand playlistinfo took 76 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand playlistinfo took 20 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand playlistinfo took 13 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand status took 11 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand status took 10 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand status took 10 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand status took 10 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand playlistinfo took 2 milliseconds May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:07 volumio volumio[878]: verbose: CURRENT POSITION 2 May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: No code May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:07 volumio volumio[878]: verbose: CURRENT POSITION 2 May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: No code May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:07 volumio volumio[878]: verbose: CURRENT POSITION 2 May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: No code May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:07 volumio volumio[878]: verbose: CURRENT POSITION 2 May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: No code May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: ------------------------------ 211ms May 22 14:11:07 volumio volumio[878]: info: ------------------------------ 212ms May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand playlistinfo took 21 milliseconds May 22 14:11:07 volumio volumio[878]: info: sendMpdCommand playlistinfo took 15 milliseconds May 22 14:11:07 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:07 volumio volumio[878]: verbose: CURRENT POSITION 2 May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: No code May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:07 volumio volumio[878]: verbose: CURRENT POSITION 2 May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: No code May 22 14:11:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:07 volumio volumio[878]: info: ------------------------------ 51ms May 22 14:11:07 volumio volumio[878]: info: ------------------------------ 50ms May 22 14:11:07 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:07 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:08 volumio sudo[6759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:08 volumio sudo[6759]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:08 volumio sudo[6759]: pam_unix(sudo:session): session closed for user root May 22 14:11:08 volumio sudo[6762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:08 volumio sudo[6762]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:08 volumio sudo[6762]: pam_unix(sudo:session): session closed for user root May 22 14:11:08 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 22 14:11:08 volumio sudo[6767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:08 volumio sudo[6767]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:08 volumio sudo[6767]: pam_unix(sudo:session): session closed for user root May 22 14:11:08 volumio sudo[6770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:08 volumio sudo[6770]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:08 volumio sudo[6770]: pam_unix(sudo:session): session closed for user root May 22 14:11:09 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::volumioGetVisibleSources May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:09 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 22 14:11:09 volumio volumio[878]: info: Received Get System Info May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:09 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:09 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:09 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:09 volumio volumio[878]: info: Listing playlists May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 14:11:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 22 14:11:10 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 22 14:11:10 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:10 volumio volumio[878]: info: Received Get System Info May 22 14:11:10 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:10 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:10 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:10 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:10 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:10 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:11 volumio volumio[878]: info: CoreCommandRouter::volumioGetQueue May 22 14:11:11 volumio volumio[878]: info: CoreStateMachine::getQueue May 22 14:11:11 volumio volumio[878]: info: CorePlayQueue::getQueue May 22 14:11:11 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:11 volumio volumio[878]: info: Received Get System Info May 22 14:11:11 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:11 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:11 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:11 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:11 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:11 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:12 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:12 volumio volumio[878]: info: CURURI: music-library May 22 14:11:12 volumio volumio[878]: info: Preload queue cleared May 22 14:11:13 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:13 volumio volumio[878]: info: CURURI: music-library/USB May 22 14:11:13 volumio volumio[878]: info: Preload queue cleared May 22 14:11:15 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:15 volumio volumio[878]: info: CURURI: music-library/USB/PenDrive May 22 14:11:15 volumio volumio[878]: info: Preload queue cleared May 22 14:11:16 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:16 volumio volumio[878]: info: CURURI: music-library/USB/PenDrive/883 May 22 14:11:16 volumio volumio[878]: info: Preload queue cleared May 22 14:11:19 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 22 14:11:23 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:23 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:23 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:23 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:23 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:23 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:23 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194:3000 from 192.168.8.184 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 May 22 14:11:23 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:23 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:23 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 22 14:11:23 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 22 14:11:24 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:24 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:24 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:24 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:24 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:24 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:25 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:25 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:25 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194:3000 from 192.168.8.184 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 May 22 14:11:25 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:25 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:25 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 22 14:11:25 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 22 14:11:25 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:25 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:26 volumio sudo[6808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:26 volumio sudo[6808]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:26 volumio sudo[6808]: pam_unix(sudo:session): session closed for user root May 22 14:11:26 volumio sudo[6811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:26 volumio sudo[6811]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:26 volumio sudo[6811]: pam_unix(sudo:session): session closed for user root May 22 14:11:26 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 22 14:11:26 volumio sudo[6816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:26 volumio sudo[6816]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:26 volumio sudo[6816]: pam_unix(sudo:session): session closed for user root May 22 14:11:26 volumio sudo[6819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:26 volumio sudo[6819]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:26 volumio sudo[6819]: pam_unix(sudo:session): session closed for user root May 22 14:11:26 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::volumioGetVisibleSources May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:26 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::volumioGetQueue May 22 14:11:26 volumio volumio[878]: info: CoreStateMachine::getQueue May 22 14:11:26 volumio volumio[878]: info: CorePlayQueue::getQueue May 22 14:11:26 volumio volumio[878]: info: Listing playlists May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 22 14:11:26 volumio volumio[878]: info: Received Get System Info May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:26 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:26 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:26 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 22 14:11:26 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 14:11:27 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 22 14:11:28 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 22 14:11:28 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:28 volumio volumio[878]: info: Received Get System Info May 22 14:11:28 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:28 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:28 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:28 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:28 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:28 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:29 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:29 volumio sudo[6832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:29 volumio sudo[6832]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:29 volumio sudo[6832]: pam_unix(sudo:session): session closed for user root May 22 14:11:29 volumio sudo[6841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:29 volumio sudo[6841]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:29 volumio sudo[6841]: pam_unix(sudo:session): session closed for user root May 22 14:11:29 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 22 14:11:29 volumio sudo[6846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:29 volumio sudo[6846]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:29 volumio sudo[6846]: pam_unix(sudo:session): session closed for user root May 22 14:11:29 volumio sudo[6849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:29 volumio sudo[6849]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:29 volumio sudo[6849]: pam_unix(sudo:session): session closed for user root May 22 14:11:29 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:29 volumio volumio[878]: info: Received Get System Info May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:29 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:29 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::volumioGetVisibleSources May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:29 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::volumioGetQueue May 22 14:11:29 volumio volumio[878]: info: CoreStateMachine::getQueue May 22 14:11:29 volumio volumio[878]: info: CorePlayQueue::getQueue May 22 14:11:29 volumio volumio[878]: info: Listing playlists May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 22 14:11:29 volumio volumio[878]: info: Received Get System Info May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:29 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:29 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:29 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 14:11:29 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 22 14:11:31 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 22 14:11:31 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:31 volumio volumio[878]: info: Received Get System Info May 22 14:11:31 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:31 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:31 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:31 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:31 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:31 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:32 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:32 volumio volumio[878]: info: Received Get System Info May 22 14:11:32 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:32 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:32 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:32 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:32 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:32 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:33 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:33 volumio volumio[878]: info: CURURI: music-library May 22 14:11:33 volumio volumio[878]: info: Preload queue cleared May 22 14:11:36 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:36 volumio volumio[878]: info: CURURI: music-library/USB May 22 14:11:36 volumio volumio[878]: info: Preload queue cleared May 22 14:11:37 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 22 14:11:37 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:37 volumio volumio[878]: info: CURURI: music-library/USB/EFI May 22 14:11:37 volumio volumio[878]: error: Failed LSINFO: null May 22 14:11:37 volumio volumio[878]: info: Preload queue cleared May 22 14:11:39 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 22 14:11:40 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:40 volumio volumio[878]: info: CURURI: music-library/USB/PenDrive May 22 14:11:40 volumio volumio[878]: info: Preload queue cleared May 22 14:11:41 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:41 volumio volumio[878]: info: CURURI: music-library/USB/PenDrive/883 May 22 14:11:41 volumio volumio[878]: info: Preload queue cleared May 22 14:11:41 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 22 14:11:41 volumio volumio[878]: info: CURURI: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno May 22 14:11:41 volumio volumio[878]: info: Preload queue cleared May 22 14:11:44 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:44 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:44 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:44 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:44 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:44 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:44 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194:3000 from 192.168.8.184 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 May 22 14:11:44 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:44 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:44 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 22 14:11:44 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 22 14:11:45 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 14:11:45 volumio volumio[878]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 22 14:11:45 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 22 14:11:45 volumio volumio[878]: info: Received Get System Version May 22 14:11:45 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 14:11:45 volumio volumio[878]: info: Received Get System Info May 22 14:11:45 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:45 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:45 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:45 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:45 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:45 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:46 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:46 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:46 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:46 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:46 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:46 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:47 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 14:11:47 volumio volumio[878]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 22 14:11:47 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 22 14:11:47 volumio volumio[878]: info: Received Get System Version May 22 14:11:47 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 14:11:47 volumio volumio[878]: info: Received Get System Info May 22 14:11:47 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:47 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:47 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:47 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:47 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:47 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:48 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:48 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:48 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194:3000 from 192.168.8.184 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 May 22 14:11:48 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:48 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:48 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 22 14:11:48 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 22 14:11:48 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:48 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:48 volumio sudo[6877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:48 volumio sudo[6877]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:48 volumio sudo[6877]: pam_unix(sudo:session): session closed for user root May 22 14:11:48 volumio sudo[6880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:48 volumio sudo[6880]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:48 volumio sudo[6880]: pam_unix(sudo:session): session closed for user root May 22 14:11:48 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 22 14:11:48 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 22 14:11:48 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 22 14:11:48 volumio sudo[6885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 14:11:48 volumio sudo[6885]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:48 volumio sudo[6885]: pam_unix(sudo:session): session closed for user root May 22 14:11:48 volumio sudo[6888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 14:11:48 volumio sudo[6888]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 14:11:48 volumio sudo[6888]: pam_unix(sudo:session): session closed for user root May 22 14:11:49 volumio volumio[878]: verbose: New Socket.io Connection to 192.168.8.194 from 192.168.8.184 UA: Mozilla/5.0 (Linux; Android 15; A015 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::volumioGetVisibleSources May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:49 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::volumioGetQueue May 22 14:11:49 volumio volumio[878]: info: CoreStateMachine::getQueue May 22 14:11:49 volumio volumio[878]: info: CorePlayQueue::getQueue May 22 14:11:49 volumio volumio[878]: info: Listing playlists May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 22 14:11:49 volumio volumio[878]: info: Received Get System Info May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:49 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:49 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:49 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 14:11:49 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 22 14:11:50 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:50 volumio volumio[878]: info: Received Get System Info May 22 14:11:50 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:50 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:50 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:50 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:50 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:50 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:50 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 22 14:11:52 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 14:11:52 volumio volumio[878]: info: Received Get System Info May 22 14:11:52 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:11:52 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:11:52 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:11:52 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:11:52 volumio volumio[878]: info: CorePlayQueue::getTrack 2 May 22 14:11:52 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:11:53 volumio volumio[878]: info: Preload queue cleared May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioReplaceandPlayItems May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::ClearQueue May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::clearPlayQueue May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::saveQueue May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushQueue May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::addQueueItems May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::addQueueItems May 22 14:11:53 volumio volumio[878]: info: Preload queue cleared May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushQueue May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::saveQueue May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::updateTrackBlock May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrackBlock May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPlay May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::play index 0 May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::addQueueItems May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::addQueueItems May 22 14:11:53 volumio volumio[878]: info: Preload queue cleared May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/02 - S'Inkazza.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/02 - S'Inkazza.aif May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/03 - 6-1-Sfigato.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/03 - 6-1-Sfigato.aif May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/04 - Te La Tiri.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/04 - Te La Tiri.aif May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/05 - Hanno Ucciso l'Uomo Ragno.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/05 - Hanno Ucciso l'Uomo Ragno.aif May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/06 - Con un Deca.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/06 - Con un Deca.aif May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/07 - Jolly Blue.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/07 - Jolly Blue.aif May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/08 - Lasciati Toccare.aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/08 - Lasciati Toccare.aif May 22 14:11:53 volumio volumio[878]: info: Adding Item to queue: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/09 - Non me la menare (gospel).aif May 22 14:11:53 volumio volumio[878]: info: Using cached record of: music-library/USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/09 - Non me la menare (gospel).aif May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushQueue May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::saveQueue May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::play index undefined May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::updateTrackBlock May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrackBlock May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::startPlaybackTimer May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::clearAddPlayTracks USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand stop May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand stop took 1 milliseconds May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand clear May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:11:53 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand clear took 0 milliseconds May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand add "USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif" May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:11:53 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:11:53 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:11:53 volumio volumio[878]: error: updateQueue error: null May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:11:53 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 1ms May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand add "USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif" took 1 milliseconds May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 0ms May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 0ms May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand play May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:11:53 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:11:53 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:11:53 volumio volumio[878]: error: Upnp client error: Error: This socket has been ended by the other party May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces state update: player May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 1ms May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand play took 0 milliseconds May 22 14:11:53 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 0ms May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 0ms May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces state update: player May 22 14:11:53 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:53 volumio volumio[878]: info: May 22 14:11:53 volumio volumio[878]: ---------------------------- MPD announces state update: player May 22 14:11:53 volumio volumio[878]: info: ControllerMpd::getState May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand clearerror May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand clearerror May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand status took 1 milliseconds May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand clearerror May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand status took 5 milliseconds May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand clearerror took 4 milliseconds May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand clearerror took 5 milliseconds May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand playlistinfo took 4 milliseconds May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand playlistinfo took 4 milliseconds May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand clearerror took 1 milliseconds May 22 14:11:53 volumio volumio[878]: info: sendMpdCommand playlistinfo took 0 milliseconds May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:53 volumio volumio[878]: verbose: ControllerMpd::parseTrackInfo May 22 14:11:53 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:53 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: No code May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:53 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: No code May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Non Me La Menare","artist":"883","album":"Hanno Ucciso L'Uomo Ragno","uri":"USB/PenDrive/883/1992 - Hanno Ucciso L'Uomo Ragno/01 - Non Me La Menare.aif","trackType":"aif"} May 22 14:11:53 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: No code May 22 14:11:53 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:11:53 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:11:53 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 14ms May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 13ms May 22 14:11:53 volumio volumio[878]: info: ------------------------------ 13ms May 22 14:11:59 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 14:12:00 volumio volumio[878]: info: Retrieving Cloud Streaming UI May 22 14:12:00 volumio volumio[878]: info: Getting Tidal Cloud Configuration May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 14:12:00 volumio volumio[878]: info: Getting Qobuz Cloud Configuration May 22 14:12:00 volumio volumio[878]: info: Asking plugin for UI Config May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 14:12:00 volumio volumio[878]: info: Getting Spotify Cloud Configuration May 22 14:12:00 volumio volumio[878]: info: Asking plugin for UI Config May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 14:12:00 volumio volumio[878]: info: Saving Spotify Acccount May 22 14:12:00 volumio volumio[878]: info: Got Tidal Cloud Configuration May 22 14:12:00 volumio volumio[878]: info: Got it May 22 14:12:00 volumio volumio[878]: info: Got it May 22 14:12:00 volumio volumio[878]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 14:12:00 volumio volumio[878]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::volumioGetBrowseSources May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::volumioGetBrowseSources May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::volumioGetBrowseSources May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 22 14:12:00 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand rescan May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:12:02 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand rescan took 4 milliseconds May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: MPD Database updated - AlbumList cache refreshed May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: database May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:02 volumio volumio[878]: error: updateQueue error: null May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 3 milliseconds May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 3ms May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 1 milliseconds May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 281ms May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 280ms May 22 14:12:02 volumio volumio[878]: info: MPD Database updated - AlbumList cache refreshed May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: database May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:12:02 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: MPD Database updated - AlbumList cache refreshed May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: database May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces system playlist update May 22 14:12:02 volumio volumio[878]: info: Ignoring MPD Status Update May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: May 22 14:12:02 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:02 volumio volumio[878]: error: updateQueue error: null May 22 14:12:02 volumio volumio[878]: error: updateQueue error: null May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 281 milliseconds May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 280 milliseconds May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 2ms May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 2ms May 22 14:12:02 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:02 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: No code May 22 14:12:02 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:02 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:02 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 322ms May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 323ms May 22 14:12:02 volumio volumio[878]: info: ------------------------------ 43ms May 22 14:12:04 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand rescan May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: info: May 22 14:12:05 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand rescan took 1 milliseconds May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: info: May 22 14:12:05 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: info: May 22 14:12:05 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: info: May 22 14:12:05 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: info: May 22 14:12:05 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: info: May 22 14:12:05 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 2 milliseconds May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 1 milliseconds May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 1 milliseconds May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: Command Router : Notfying DB Updatetrue May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: Command Router : Notfying DB Updatetrue May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: Command Router : Notfying DB Updatetrue May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:05 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: No code May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:05 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: No code May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:05 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: No code May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:05 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: No code May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:05 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: No code May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: ------------------------------ 172ms May 22 14:12:05 volumio volumio[878]: info: ------------------------------ 171ms May 22 14:12:05 volumio volumio[878]: info: sendMpdCommand status took 171 milliseconds May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:05 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:05 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:05 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: No code May 22 14:12:05 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:05 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:05 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:05 volumio volumio[878]: info: ------------------------------ 200ms May 22 14:12:06 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 22 14:12:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand update May 22 14:12:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:06 volumio volumio[878]: info: May 22 14:12:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:06 volumio volumio[878]: info: sendMpdCommand update took 1 milliseconds May 22 14:12:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:06 volumio volumio[878]: info: May 22 14:12:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:06 volumio volumio[878]: info: May 22 14:12:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:06 volumio volumio[878]: info: May 22 14:12:06 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:06 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:06 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:06 volumio volumio[878]: info: sendMpdCommand status took 5 milliseconds May 22 14:12:06 volumio volumio[878]: info: sendMpdCommand status took 4 milliseconds May 22 14:12:06 volumio volumio[878]: info: sendMpdCommand status took 1 milliseconds May 22 14:12:06 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:07 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: No code May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:07 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: No code May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: ------------------------------ 159ms May 22 14:12:07 volumio volumio[878]: info: ------------------------------ 155ms May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:07 volumio volumio[878]: info: May 22 14:12:07 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:07 volumio volumio[878]: info: sendMpdCommand status took 156 milliseconds May 22 14:12:07 volumio volumio[878]: info: sendMpdCommand status took 156 milliseconds May 22 14:12:07 volumio volumio[878]: info: sendMpdCommand status took 155 milliseconds May 22 14:12:07 volumio volumio[878]: info: sendMpdCommand status took 155 milliseconds May 22 14:12:07 volumio volumio[878]: info: sendMpdCommand status took 0 milliseconds May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:07 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: No code May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:07 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: No code May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:07 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: No code May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: ------------------------------ 187ms May 22 14:12:07 volumio volumio[878]: info: ------------------------------ 186ms May 22 14:12:07 volumio volumio[878]: info: ------------------------------ 32ms May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:07 volumio volumio[878]: info: May 22 14:12:07 volumio volumio[878]: ---------------------------- MPD announces state update: update May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::getState May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::sendMpdCommand status May 22 14:12:07 volumio volumio[878]: info: sendMpdCommand status took 5 milliseconds May 22 14:12:07 volumio volumio[878]: info: sendMpdCommand status took 5 milliseconds May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: Command Router : Notfying DB Updatefalse May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::Close All Modals sent May 22 14:12:07 volumio volumio[878]: verbose: ControllerMpd::parseState May 22 14:12:07 volumio volumio[878]: info: ControllerMpd::pushState May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::servicePushState May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 22 14:12:07 volumio volumio[878]: verbose: CURRENT POSITION 0 May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState stateService stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::syncState currentStatus stop May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: No code May 22 14:12:07 volumio volumio[878]: info: CoreStateMachine::pushState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioPushState May 22 14:12:07 volumio volumio[878]: info: ------------------------------ 17ms May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 14:12:07 volumio volumio[878]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 22 14:12:07 volumio volumio[878]: info: Received Get System Version May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 14:12:07 volumio volumio[878]: info: Received Get System Info May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 14:12:07 volumio volumio[878]: info: Discovery: Getting this device information May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::volumioGetState May 22 14:12:07 volumio volumio[878]: info: CorePlayQueue::getTrack 0 May 22 14:12:07 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 14:12:08 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 22 14:12:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 22 14:12:09 volumio volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 22 14:12:09 volumio volumio[878]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 14:12:09 volumio volumio[878]: Error: getaddrinfo -3007 May 22 14:12:09 volumio volumio[878]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) May 22 14:12:09 volumio volumio[878]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) May 22 14:12:09 volumio volumio[878]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { May 22 14:12:09 volumio volumio[878]: code: -3007, May 22 14:12:09 volumio volumio[878]: errno: -3007, May 22 14:12:09 volumio volumio[878]: syscall: 'getaddrinfo' May 22 14:12:09 volumio volumio[878]: } May 22 14:12:09 volumio volumio[878]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 14:12:09 volumio sudo[7044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 14:11 May 22 14:12:09 volumio sudo[7044]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"