-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Mon 2025-12-22 21:29:53 CET. -- Dec 22 21:28:03 volumio-primo kernel: ......ready Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] Very big device. Trying to use READ CAPACITY(16). Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] 11720978432 512-byte logical blocks: (6.00 TB/5.46 TiB) Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] 4096-byte physical blocks Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] Write Protect is off Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] Mode Sense: 47 00 10 08 Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] No Caching mode page found Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] Assuming drive cache: write through Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] Very big device. Trying to use READ CAPACITY(16). Dec 22 21:28:03 volumio-primo kernel: sda: sda1 Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] Very big device. Trying to use READ CAPACITY(16). Dec 22 21:28:03 volumio-primo kernel: sd 1:0:0:0: [sda] Attached SCSI disk Dec 22 21:28:03 volumio-primo volumio[1303]: info: Mounting Device Elements Dec 22 21:28:03 volumio-primo sudo[2077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Elements -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Dec 22 21:28:03 volumio-primo sudo[2077]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:08 volumio-primo go-librespot[1584]: time="2025-12-22T21:28:08+01:00" level=trace msg="sent dealer ping" Dec 22 21:28:08 volumio-primo go-librespot[1584]: time="2025-12-22T21:28:08+01:00" level=trace msg="received dealer pong" Dec 22 21:28:11 volumio-primo ntfs-3g[2085]: Version 2017.3.23AR.3 integrated FUSE 28 Dec 22 21:28:11 volumio-primo sudo[2077]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:11 volumio-primo ntfs-3g[2085]: Mounted /dev/sda1 (Read-Write, label "Elements", NTFS 3.1) Dec 22 21:28:11 volumio-primo ntfs-3g[2085]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Dec 22 21:28:11 volumio-primo ntfs-3g[2085]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Dec 22 21:28:11 volumio-primo ntfs-3g[2085]: Global ownership and permissions enforced, configuration type 7 Dec 22 21:28:11 volumio-primo volumio[1303]: The disk contains an unclean file system (0, 0). Dec 22 21:28:11 volumio-primo volumio[1303]: The file system wasn't safely closed on Windows. Fixing. Dec 22 21:28:11 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.48:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 22 21:28:11 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:11 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:11 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:11 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:11 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:11 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:11 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:11 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:11 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 22 21:28:11 volumio-primo sudo[2090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 22 21:28:11 volumio-primo sudo[2090]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:11 volumio-primo sudo[2096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 21:28:11 volumio-primo sudo[2090]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:11 volumio-primo sudo[2103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 21:28:11 volumio-primo sudo[2096]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:11 volumio-primo sudo[2103]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:11 volumio-primo sudo[2096]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:11 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 22 21:28:11 volumio-primo sudo[2114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 21:28:11 volumio-primo sudo[2125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 21:28:11 volumio-primo sudo[2103]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:11 volumio-primo sudo[2131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 21:28:11 volumio-primo sudo[2114]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2131]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2114]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo sudo[2125]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2131]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo sudo[2146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 22 21:28:12 volumio-primo sudo[2125]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo sudo[2146]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 21:28:12 volumio-primo sudo[2146]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo sudo[2172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 21:28:12 volumio-primo sudo[2179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 21:28:12 volumio-primo sudo[2163]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2172]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 21:28:12 volumio-primo sudo[2179]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2163]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo sudo[2172]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo sudo[2179]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo sudo[2193]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo sudo[2205]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:12 volumio-primo sudo[2193]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo sudo[2205]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.48:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.48:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.48:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:12 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:12 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:12 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:12 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:13 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:13 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:13 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:13 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:13 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:13 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.48:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:13 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:14 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:14 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:14 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:14 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:14 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:14 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.48:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:14 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:15 volumio-primo sudo[2253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 21:28:15 volumio-primo sudo[2256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 21:28:15 volumio-primo sudo[2253]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:15 volumio-primo sudo[2253]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:15 volumio-primo sudo[2256]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:15 volumio-primo sudo[2256]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:15 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102 from 192.168.178.49 UA: Mozilla/5.0 (Linux; Android 16; SM-X210 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.35 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 22 21:28:16 volumio-primo sudo[2273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 21:28:16 volumio-primo sudo[2275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 21:28:16 volumio-primo sudo[2273]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:16 volumio-primo sudo[2275]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:28:16 volumio-primo sudo[2273]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:16 volumio-primo sudo[2275]: pam_unix(sudo:session): session closed for user root Dec 22 21:28:16 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102 from 192.168.178.49 UA: Mozilla/5.0 (Linux; Android 16; SM-X210 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.35 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetVisibleSources Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:16 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 22 21:28:16 volumio-primo volumio[1303]: info: Received Get System Info Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:16 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:16 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:16 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:16 volumio-primo volumio[1303]: info: Listing playlists Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 22 21:28:16 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 21:28:17 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:17 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:17 volumio-primo volumiologrotate[571]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Dec 22 21:28:17 volumio-primo volumiologrotate[571]: ls: cannot access 'PRIMO': No such file or directory Dec 22 21:28:18 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 21:28:18 volumio-primo volumio[1303]: info: Received Get System Info Dec 22 21:28:18 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:18 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:18 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:18 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:18 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:18 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:18 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 22 21:28:19 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 21:28:19 volumio-primo volumio[1303]: info: Received Get System Info Dec 22 21:28:19 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:19 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:19 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:19 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:22 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetQueue Dec 22 21:28:22 volumio-primo volumio[1303]: info: CoreStateMachine::getQueue Dec 22 21:28:22 volumio-primo volumio[1303]: info: CorePlayQueue::getQueue Dec 22 21:28:26 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 22 21:28:28 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:28 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 21:28:32 volumio-primo volumio[1303]: info: Retrieving Cloud Streaming UI Dec 22 21:28:32 volumio-primo volumio[1303]: info: Getting Tidal Cloud Configuration Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 21:28:32 volumio-primo volumio[1303]: info: Getting Qobuz Cloud Configuration Dec 22 21:28:32 volumio-primo volumio[1303]: info: Asking plugin for UI Config Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 21:28:32 volumio-primo volumio[1303]: info: Getting Spotify Cloud Configuration Dec 22 21:28:32 volumio-primo volumio[1303]: info: Asking plugin for UI Config Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 21:28:32 volumio-primo volumio[1303]: info: Saving Spotify Acccount Dec 22 21:28:32 volumio-primo volumio[1303]: info: Got Tidal Cloud Configuration Dec 22 21:28:32 volumio-primo volumio[1303]: info: Got it Dec 22 21:28:32 volumio-primo volumio[1303]: info: Got it Dec 22 21:28:32 volumio-primo volumio[1303]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 21:28:32 volumio-primo volumio[1303]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 21:28:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:34 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:34 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:34 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.102:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:34 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:34 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:34 volumio-primo volumio[1303]: verbose: New Socket.io Connection to 192.168.178.48:3000 from 192.168.178.49 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 21:28:34 volumio-primo volumio[1303]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 22 21:28:34 volumio-primo volumio[1303]: info: Received Get System Version Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 21:28:34 volumio-primo volumio[1303]: info: Received Get System Info Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 21:28:34 volumio-primo volumio[1303]: info: Discovery: Getting this device information Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:34 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:34 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand update Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:28:36 volumio-primo volumio[1303]: info: Dec 22 21:28:36 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:28:36 volumio-primo volumio[1303]: info: sendMpdCommand update took 5 milliseconds Dec 22 21:28:36 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:28:36 volumio-primo volumio[1303]: info: sendMpdCommand status took 6 milliseconds Dec 22 21:28:36 volumio-primo volumio[1303]: info: sendMpdCommand status took 3 milliseconds Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:28:36 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatetrue Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:28:36 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: 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} Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: No code Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: ------------------------------ 71ms Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:28:36 volumio-primo volumio[1303]: info: Dec 22 21:28:36 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:28:36 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:28:36 volumio-primo volumio[1303]: info: Dec 22 21:28:36 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:28:36 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:28:36 volumio-primo volumio[1303]: info: sendMpdCommand status took 5 milliseconds Dec 22 21:28:36 volumio-primo volumio[1303]: info: sendMpdCommand status took 3 milliseconds Dec 22 21:28:36 volumio-primo volumio[1303]: info: sendMpdCommand status took 3 milliseconds Dec 22 21:28:36 volumio-primo volumio[1303]: info: sendMpdCommand status took 2 milliseconds Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:28:36 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatetrue Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:28:36 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatetrue Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:28:36 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: 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} Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: No code Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: 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} Dec 22 21:28:36 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: No code Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:28:36 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:28:36 volumio-primo volumio[1303]: info: ------------------------------ 103ms Dec 22 21:28:36 volumio-primo volumio[1303]: info: ------------------------------ 100ms Dec 22 21:28:38 volumio-primo go-librespot[1584]: time="2025-12-22T21:28:38+01:00" level=trace msg="sent dealer ping" Dec 22 21:28:38 volumio-primo go-librespot[1584]: time="2025-12-22T21:28:38+01:00" level=trace msg="received dealer pong" Dec 22 21:28:40 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 21:28:44 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 21:28:46 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 22 21:28:46 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand update Dec 22 21:28:46 volumio-primo volumio[1303]: info: sendMpdCommand update took 2 milliseconds Dec 22 21:28:48 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 21:28:51 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:28:51 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 983 Dec 22 21:28:51 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:28:51 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 983 Dec 22 21:28:52 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 21:28:54 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioGetState Dec 22 21:28:54 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:00 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 21:29:00 volumio-primo volumio[1303]: info: CURURI: music-library Dec 22 21:29:00 volumio-primo volumio[1303]: info: Preload queue cleared Dec 22 21:29:02 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 21:29:02 volumio-primo volumio[1303]: info: CURURI: music-library/USB Dec 22 21:29:02 volumio-primo volumio[1303]: info: Preload queue cleared Dec 22 21:29:04 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 21:29:04 volumio-primo volumio[1303]: info: CURURI: music-library/USB/Elements Dec 22 21:29:04 volumio-primo volumio[1303]: info: Preload queue cleared Dec 22 21:29:08 volumio-primo go-librespot[1584]: time="2025-12-22T21:29:08+01:00" level=trace msg="sent dealer ping" Dec 22 21:29:08 volumio-primo go-librespot[1584]: time="2025-12-22T21:29:08+01:00" level=trace msg="received dealer pong" Dec 22 21:29:17 volumio-primo volumiologrotate[571]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Dec 22 21:29:17 volumio-primo volumiologrotate[571]: ls: cannot access 'PRIMO': No such file or directory Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58545 Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58545 Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58565 Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:18 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58565 Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:19 volumio-primo volumio[1303]: info: Dec 22 21:29:19 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:29:19 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:19 volumio-primo volumio[1303]: info: Dec 22 21:29:19 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:29:19 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:19 volumio-primo volumio[1303]: info: sendMpdCommand status took 4 milliseconds Dec 22 21:29:19 volumio-primo volumio[1303]: info: sendMpdCommand status took 2 milliseconds Dec 22 21:29:19 volumio-primo volumio[1303]: info: sendMpdCommand status took 3 milliseconds Dec 22 21:29:19 volumio-primo volumio[1303]: info: sendMpdCommand status took 2 milliseconds Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:19 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatetrue Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:19 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatetrue Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:19 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: 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} Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: No code Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: 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} Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: No code Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: ------------------------------ 126ms Dec 22 21:29:19 volumio-primo volumio[1303]: info: ------------------------------ 125ms Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:19 volumio-primo volumio[1303]: info: Dec 22 21:29:19 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:29:19 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:19 volumio-primo volumio[1303]: info: sendMpdCommand status took 2 milliseconds Dec 22 21:29:19 volumio-primo volumio[1303]: info: sendMpdCommand status took 1 milliseconds Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:19 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatetrue Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:19 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: 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} Dec 22 21:29:19 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: No code Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:19 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:19 volumio-primo volumio[1303]: info: ------------------------------ 59ms Dec 22 21:29:24 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:24 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 983 Dec 22 21:29:24 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:24 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 983 Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58545 Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58545 Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58565 Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 0: Invalid argument Dec 22 21:29:31 volumio-primo ntfs-3g[2085]: Corrupt index block signature: vcn 0 inode 58565 Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:32 volumio-primo volumio[1303]: info: Dec 22 21:29:32 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:29:32 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:32 volumio-primo volumio[1303]: info: sendMpdCommand status took 1 milliseconds Dec 22 21:29:32 volumio-primo volumio[1303]: info: sendMpdCommand status took 1 milliseconds Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:32 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatefalse Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:32 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: 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} Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: No code Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: ------------------------------ 62ms Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:32 volumio-primo volumio[1303]: info: Dec 22 21:29:32 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:29:32 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:32 volumio-primo volumio[1303]: info: Dec 22 21:29:32 volumio-primo volumio[1303]: ---------------------------- MPD announces state update: update Dec 22 21:29:32 volumio-primo volumio[1303]: info: ControllerMpd::getState Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::sendMpdCommand status Dec 22 21:29:32 volumio-primo volumio[1303]: info: sendMpdCommand status took 3 milliseconds Dec 22 21:29:32 volumio-primo volumio[1303]: info: sendMpdCommand status took 2 milliseconds Dec 22 21:29:32 volumio-primo volumio[1303]: info: sendMpdCommand status took 2 milliseconds Dec 22 21:29:32 volumio-primo volumio[1303]: info: sendMpdCommand status took 1 milliseconds Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:32 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatefalse Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:32 volumio-primo volumio[1303]: info: Command Router : Notfying DB Updatefalse Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: ControllerMpd::parseState Dec 22 21:29:32 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: 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} Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: No code Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: ControllerMpd::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::servicePushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: 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} Dec 22 21:29:32 volumio-primo volumio[1303]: verbose: CURRENT POSITION 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::syncState stateService stop Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::syncState currentStatus stop Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: No code Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreStateMachine::pushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: CorePlayQueue::getTrack 0 Dec 22 21:29:32 volumio-primo volumio[1303]: info: CoreCommandRouter::volumioPushState Dec 22 21:29:32 volumio-primo volumio[1303]: info: ------------------------------ 105ms Dec 22 21:29:32 volumio-primo volumio[1303]: info: ------------------------------ 105ms Dec 22 21:29:33 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 21:29:33 volumio-primo volumio[1303]: info: CURURI: music-library/USB/Elements/Carla Bruni - French Touch Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preload queue cleared Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/01 Enjoy The Silence.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/02 Jimmy Jazz.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/03 Love Letters.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/04 Miss You.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/05 The Winner Takes It All.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/06 Crazy.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/07 Highway To Hell.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/08 Perfect Day.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/09 Stand By Your Man.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/10 Please Don’t Kiss Me.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Preloading song: music-library/USB/Elements/Carla Bruni - French Touch/11 Moon River.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/01 Enjoy The Silence.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F01%20Enjoy%20The%20Silence.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/01 Enjoy The Silence.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/02 Jimmy Jazz.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F02%20Jimmy%20Jazz.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/02 Jimmy Jazz.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/03 Love Letters.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F03%20Love%20Letters.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/03 Love Letters.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/04 Miss You.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F04%20Miss%20You.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/04 Miss You.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/05 The Winner Takes It All.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F05%20The%20Winner%20Takes%20It%20All.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/05 The Winner Takes It All.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/06 Crazy.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F06%20Crazy.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/06 Crazy.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/07 Highway To Hell.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F07%20Highway%20To%20Hell.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/07 Highway To Hell.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/08 Perfect Day.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F08%20Perfect%20Day.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/08 Perfect Day.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/09 Stand By Your Man.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F09%20Stand%20By%20Your%20Man.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/09 Stand By Your Man.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/10 Please Don’t Kiss Me.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F10%20Please%20Don%E2%80%99t%20Kiss%20Me.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/10 Please Don’t Kiss Me.flac Dec 22 21:29:33 volumio-primo volumio[1303]: info: Exploding uri music-library/USB/Elements/Carla Bruni - French Touch/11 Moon River.flac in service mpd Dec 22 21:29:33 volumio-primo volumio[1303]: info: ALBUMART /albumart?cacheid=128&web=Carla%20Bruni/French%20Touch/extralarge&path=%2Fmnt%2FUSB%2FElements%2FCarla%20Bruni%20-%20French%20Touch%2F11%20Moon%20River.flac&metadata=false Dec 22 21:29:33 volumio-primo volumio[1303]: info: URI /mnt/USB/Elements/Carla Bruni - French Touch/11 Moon River.flac Dec 22 21:29:38 volumio-primo go-librespot[1584]: time="2025-12-22T21:29:38+01:00" level=trace msg="received accesspoint ping" Dec 22 21:29:38 volumio-primo go-librespot[1584]: time="2025-12-22T21:29:38+01:00" level=trace msg="received accesspoint pong ack" Dec 22 21:29:38 volumio-primo go-librespot[1584]: time="2025-12-22T21:29:38+01:00" level=trace msg="sent dealer ping" Dec 22 21:29:38 volumio-primo go-librespot[1584]: time="2025-12-22T21:29:38+01:00" level=trace msg="received dealer pong" Dec 22 21:29:45 volumio-primo volumio[1303]: Searching plugin music_service/mpd Dec 22 21:29:45 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 22 21:29:46 volumio-primo volumio[1303]: info: All search sources collected, pushing search results Dec 22 21:29:49 volumio-primo volumio[1303]: Searching plugin music_service/mpd Dec 22 21:29:49 volumio-primo volumio[1303]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 22 21:29:49 volumio-primo volumio[1303]: info: All search sources collected, pushing search results Dec 22 21:29:52 volumio-primo volumio[1303]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 21:29:52 volumio-primo volumio[1303]: TypeError: Cannot read property 'slice' of null Dec 22 21:29:52 volumio-primo volumio[1303]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 22 21:29:52 volumio-primo volumio[1303]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 22 21:29:52 volumio-primo volumio[1303]: at Object.onceWrapper (events.js:520:26) Dec 22 21:29:52 volumio-primo volumio[1303]: at ClientRequest.emit (events.js:400:28) Dec 22 21:29:52 volumio-primo volumio[1303]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Dec 22 21:29:52 volumio-primo volumio[1303]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Dec 22 21:29:52 volumio-primo volumio[1303]: at TLSSocket.socketOnData (_http_client.js:515:22) Dec 22 21:29:52 volumio-primo volumio[1303]: at TLSSocket.emit (events.js:400:28) Dec 22 21:29:52 volumio-primo volumio[1303]: at addChunk (internal/streams/readable.js:293:12) Dec 22 21:29:52 volumio-primo volumio[1303]: at readableAddChunk (internal/streams/readable.js:267:9) Dec 22 21:29:52 volumio-primo volumio[1303]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 21:29:53 volumio-primo sudo[2564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-22 21:28 Dec 22 21:29:53 volumio-primo sudo[2564]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 07:17:52 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="3b20d491450ccf59e0e519a97572dc60"