oct. 11 12:41:14 chatbry systemd[1]: setdatetime-helper.service: Deactivated successfully. oct. 11 12:41:14 chatbry systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. oct. 11 12:41:14 chatbry systemd[1]: setdatetime-helper.service: Consumed 1.445s CPU time. oct. 11 12:41:14 chatbry winbindd[1090]: [2026/10/11 12:41:14.266741, 0] ../../source3/winbindd/winbindd.c:1440(main) oct. 11 12:41:14 chatbry winbindd[1090]: winbindd version 4.17.8-Raspbian started. oct. 11 12:41:14 chatbry winbindd[1090]: Copyright Andrew Tridgell and the Samba Team 1992-2022 oct. 11 12:41:14 chatbry winbindd[1090]: [2026/10/11 12:41:14.287779, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) oct. 11 12:41:14 chatbry winbindd[1090]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 oct. 11 12:41:14 chatbry systemd[1]: Started winbind.service - Samba Winbind Daemon. oct. 11 12:41:14 chatbry systemd[1]: Starting smbd.service - Samba SMB Daemon... oct. 11 12:41:14 chatbry ntpd[923]: IO: Listen normally on 3 eth0 192.168.1.64:123 oct. 11 12:41:14 chatbry ntpd[923]: IO: new interface(s) found: waking up resolver oct. 11 12:41:14 chatbry ntpd[923]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 oct. 11 12:41:14 chatbry ntpd[923]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 oct. 11 12:41:14 chatbry ntpd[923]: DNS: Pool taking: 82.64.55.167 oct. 11 12:41:14 chatbry ntpd[923]: DNS: Pool taking: 5.196.76.84 oct. 11 12:41:14 chatbry ntpd[923]: DNS: Pool taking: 82.64.141.144 oct. 11 12:41:14 chatbry ntpd[923]: DNS: Pool taking: 23.161.104.133 oct. 11 12:41:14 chatbry ntpd[923]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 oct. 11 12:41:15 chatbry kernel: usb 1-1-port2: over-current change #4 oct. 11 12:41:15 chatbry smbd[1112]: [2026/10/11 12:41:15.145645, 0] ../../source3/smbd/server.c:1741(main) oct. 11 12:41:15 chatbry smbd[1112]: smbd version 4.17.8-Raspbian started. oct. 11 12:41:15 chatbry smbd[1112]: Copyright Andrew Tridgell and the Samba Team 1992-2022 oct. 11 12:41:15 chatbry kernel: usb 1-1.1-port2: over-current change #4 oct. 11 12:41:15 chatbry kernel: usb 1-1-port3: over-current change #4 oct. 11 12:41:15 chatbry kernel: usb 1-1.1-port3: over-current change #4 oct. 11 12:41:15 chatbry kernel: usb 1-1-port4: over-current change #4 oct. 11 12:41:15 chatbry kernel: usb 1-1-port2: over-current change #5 oct. 11 12:41:15 chatbry ntpd[923]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 oct. 11 12:41:15 chatbry ntpd[923]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 79.143.250.33 oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 212.83.187.62 oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 185.51.192.62 oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 82.67.41.119 oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 2001:41d0:701:1100::285d oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 2001:41d0:203:526b::123 oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 2001:41d0:700:6d9a:: oct. 11 12:41:15 chatbry ntpd[923]: DNS: Pool taking: 2001:41d0:fc20:2e30::253 oct. 11 12:41:15 chatbry ntpd[923]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 oct. 11 12:41:16 chatbry kernel: usb 1-1-port3: over-current change #5 oct. 11 12:41:16 chatbry kernel: usb 1-1-port4: over-current change #5 oct. 11 12:41:16 chatbry kernel: usb 1-1-port2: over-current change #6 oct. 11 12:41:16 chatbry dhcpcd[616]: eth0: leased 192.168.1.64 for 86400 seconds oct. 11 12:41:16 chatbry dhcpcd[616]: eth0: adding route to 192.168.1.0/24 oct. 11 12:41:16 chatbry dhcpcd[616]: eth0: adding default route via 192.168.1.1 oct. 11 12:41:16 chatbry sh[612]: eth0: leased 192.168.1.64 for 86400 seconds oct. 11 12:41:16 chatbry sh[612]: eth0: adding route to 192.168.1.0/24 oct. 11 12:41:16 chatbry sh[612]: eth0: adding default route via 192.168.1.1 oct. 11 12:41:16 chatbry kernel: usb 1-1.1-port2: over-current change #5 oct. 11 12:41:16 chatbry sh[612]: forked to background, child pid 615 oct. 11 12:41:16 chatbry systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. oct. 11 12:41:16 chatbry systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... oct. 11 12:41:16 chatbry systemd[1]: welcome.service: Deactivated successfully. oct. 11 12:41:16 chatbry systemd[1]: Stopped welcome.service - Show a welcome message on console. oct. 11 12:41:16 chatbry systemd[1]: Stopping welcome.service - Show a welcome message on console... oct. 11 12:41:16 chatbry systemd[1]: Starting welcome.service - Show a welcome message on console... oct. 11 12:41:16 chatbry welcome[1147]: Resolved ip:[1] 192.168.1.64 oct. 11 12:41:16 chatbry systemd[1]: Finished welcome.service - Show a welcome message on console. oct. 11 12:41:16 chatbry systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. oct. 11 12:41:16 chatbry kernel: usb 1-1.1.2: USB disconnect, device number 7 oct. 11 12:41:16 chatbry kernel: sda: detected capacity change from 30081024 to 0 oct. 11 12:41:16 chatbry ntpd[923]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 oct. 11 12:41:16 chatbry ntpd[923]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 oct. 11 12:41:16 chatbry ntpd[923]: DNS: Pool taking: 185.51.192.61 oct. 11 12:41:16 chatbry ntpd[923]: DNS: Pool skipping: 5.196.76.84 oct. 11 12:41:16 chatbry ntpd[923]: DNS: Pool taking: 51.68.232.126 oct. 11 12:41:16 chatbry ntpd[923]: DNS: Pool taking: 45.90.162.253 oct. 11 12:41:16 chatbry ntpd[923]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 oct. 11 12:41:16 chatbry ifplugd(eth0)[954]: client: ifup: interface eth0 already configured oct. 11 12:41:16 chatbry sh[1179]: eth0=eth0 oct. 11 12:41:17 chatbry kernel: usb 1-1.1-port3: over-current change #5 oct. 11 12:41:17 chatbry ifplugd(eth0)[954]: Program executed successfully. oct. 11 12:41:17 chatbry ifplugd[905]: Network Interface Plugging Daemon...start eth0...done. oct. 11 12:41:17 chatbry systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. oct. 11 12:41:17 chatbry systemd[1]: Started smbd.service - Samba SMB Daemon. oct. 11 12:41:17 chatbry systemd[1]: Reached target multi-user.target - Multi-User System. oct. 11 12:41:17 chatbry systemd[1]: Reached target graphical.target - Graphical Interface. oct. 11 12:41:17 chatbry systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... oct. 11 12:41:17 chatbry systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. oct. 11 12:41:17 chatbry systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. oct. 11 12:41:17 chatbry systemd[1]: Startup finished in 15.480s (kernel) + 17.457s (userspace) = 32.937s. oct. 11 12:41:17 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 8 using dwc_otg oct. 11 12:41:17 chatbry kernel: usb 1-1.1.2: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 oct. 11 12:41:17 chatbry kernel: usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 oct. 11 12:41:17 chatbry kernel: usb 1-1.1.2: Product: SanDisk 3.2Gen1 oct. 11 12:41:17 chatbry kernel: usb 1-1.1.2: Manufacturer: USB oct. 11 12:41:17 chatbry kernel: usb 1-1.1.2: SerialNumber: 01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476 oct. 11 12:41:17 chatbry kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected oct. 11 12:41:17 chatbry kernel: scsi host0: usb-storage 1-1.1.2:1.0 oct. 11 12:41:17 chatbry ntpd[923]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 oct. 11 12:41:17 chatbry ntpd[923]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 oct. 11 12:41:17 chatbry ntpd[923]: DNS: Pool taking: 193.200.43.105 oct. 11 12:41:17 chatbry ntpd[923]: DNS: Pool taking: 51.91.83.168 oct. 11 12:41:17 chatbry ntpd[923]: DNS: Pool taking: 162.159.200.1 oct. 11 12:41:17 chatbry ntpd[923]: DNS: Pool taking: 45.140.164.53 oct. 11 12:41:17 chatbry ntpd[923]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 oct. 11 12:41:18 chatbry volumio-remote-updater[636]: [2026-10-11 12:41:18] [info] asio async_connect error: asio.system:111 (Connection refused) oct. 11 12:41:18 chatbry volumio-remote-updater[636]: [2026-10-11 12:41:18] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) oct. 11 12:41:18 chatbry volumio-remote-updater[636]: [2026-10-11 12:41:18] [error] handle_connect error: Connection refused oct. 11 12:41:18 chatbry kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6 oct. 11 12:41:18 chatbry kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 oct. 11 12:41:18 chatbry kernel: sd 0:0:0:0: [sda] 30081024 512-byte logical blocks: (15.4 GB/14.3 GiB) oct. 11 12:41:18 chatbry kernel: sd 0:0:0:0: [sda] Write Protect is off oct. 11 12:41:18 chatbry kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 oct. 11 12:41:18 chatbry kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA oct. 11 12:41:18 chatbry kernel: sda: sda1 oct. 11 12:41:18 chatbry kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk oct. 11 12:41:20 chatbry volumio[1033]: info: ------------------------------------------- oct. 11 12:41:20 chatbry volumio[1033]: info: ----- Volumio3 ---- oct. 11 12:41:20 chatbry volumio[1033]: info: ------------------------------------------- oct. 11 12:41:20 chatbry volumio[1033]: info: ----- System startup ---- oct. 11 12:41:20 chatbry volumio[1033]: info: ------------------------------------------- oct. 11 12:41:21 chatbry ntpd[923]: CLOCK: time stepped by 0.159534 oct. 11 12:41:21 chatbry ntpd[923]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes oct. 11 12:41:21 chatbry systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. oct. 11 12:41:21 chatbry systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. oct. 11 12:41:21 chatbry systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. oct. 11 12:41:21 chatbry upmpdcli[1196]: Could not open config: /tmp/upmpdcli.conf oct. 11 12:41:21 chatbry systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE oct. 11 12:41:21 chatbry systemd[1]: upmpdcli.service: Failed with result 'exit-code'. oct. 11 12:41:22 chatbry volumio[1033]: info: MYVOLUMIO Environment detected oct. 11 12:41:22 chatbry volumio[1033]: info: Plugin folders cleanup oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning into folder /volumio/app/plugins/ oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category audio_interface oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category miscellanea oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category music_service oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category plugins.json oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category system_controller oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category user_interface oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning into folder /data/plugins/ oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category system_controller oct. 11 12:41:22 chatbry volumio[1033]: info: Scanning category user_interface oct. 11 12:41:22 chatbry volumio[1033]: info: Plugin folders cleanup completed oct. 11 12:41:22 chatbry volumio[1033]: info: ------------------------------------------- oct. 11 12:41:22 chatbry volumio[1033]: info: ----- Core plugins startup ---- oct. 11 12:41:22 chatbry volumio[1033]: info: ------------------------------------------- oct. 11 12:41:22 chatbry volumio[1033]: info: Loading plugins from folder /volumio/app/plugins/ oct. 11 12:41:22 chatbry volumio[1033]: info: Adding plugin upnp to MyMusic Plugins oct. 11 12:41:22 chatbry volumio[1033]: info: Adding plugin airplay_emulation to MyMusic Plugins oct. 11 12:41:22 chatbry volumio[1033]: info: Adding plugin upnp_browser to MyMusic Plugins oct. 11 12:41:22 chatbry volumio[1033]: info: Loading plugins from folder /data/plugins/ oct. 11 12:41:22 chatbry volumio[1033]: info: Loading plugin "system"... oct. 11 12:41:22 chatbry volumio[1033]: info: Loading plugin "appearance"... oct. 11 12:41:25 chatbry volumio[1033]: info: Loading plugin "network"... oct. 11 12:41:25 chatbry volumio[1033]: info: Refreshing Cached IP Addresses oct. 11 12:41:25 chatbry sudo[1207]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 oct. 11 12:41:25 chatbry sudo[1207]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:25 chatbry volumio[1033]: info: Loading plugin "services"... oct. 11 12:41:25 chatbry sudo[1207]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:25 chatbry volumio[1033]: info: Loading plugin "alsa_controller"... oct. 11 12:41:25 chatbry sudo[1206]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 oct. 11 12:41:25 chatbry sudo[1206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:25 chatbry sudo[1206]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:25 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion oct. 11 12:41:25 chatbry volumio[1033]: info: Loading plugin "wizard"... oct. 11 12:41:25 chatbry volumio[1033]: info: Loading plugin "networkfs"... oct. 11 12:41:25 chatbry volumio[1033]: info: Starting Udev Watcher for removable devices oct. 11 12:41:25 chatbry volumio[1033]: info: Ignoring mount for partition: boot oct. 11 12:41:25 chatbry volumio[1033]: info: Ignoring mount for partition: volumio oct. 11 12:41:25 chatbry volumio[1033]: info: Ignoring mount for partition: volumio_data oct. 11 12:41:25 chatbry kernel: usb 1-1.1-port2: over-current change #6 oct. 11 12:41:25 chatbry volumio[1033]: info: Mounting Device 61BB-782A oct. 11 12:41:25 chatbry sudo[1242]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/61BB-782A -o noatime,dmask=0000,fmask=0000,iocharset=utf8 oct. 11 12:41:25 chatbry sudo[1242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:25 chatbry kernel: usb 1-1-port2: over-current change #7 oct. 11 12:41:25 chatbry kernel: usb 1-1.1-port3: over-current change #6 oct. 11 12:41:26 chatbry kernel: usb 1-1-port3: over-current change #6 oct. 11 12:41:26 chatbry kernel: usb 1-1-port3: over-current condition oct. 11 12:41:26 chatbry kernel: usb 1-1-port4: over-current change #6 oct. 11 12:41:26 chatbry kernel: usb 1-1-port2: over-current change #8 oct. 11 12:41:26 chatbry kernel: usb 1-1.1-port2: over-current change #7 oct. 11 12:41:26 chatbry kernel: usb 1-1-port3: over-current change #7 oct. 11 12:41:26 chatbry kernel: usb 1-1.1.2: USB disconnect, device number 8 oct. 11 12:41:26 chatbry kernel: sda: detected capacity change from 30081024 to 0 oct. 11 12:41:26 chatbry kernel: usb 1-1-port4: over-current change #7 oct. 11 12:41:27 chatbry kernel: Buffer I/O error on dev sda1, logical block 3760096, async page read oct. 11 12:41:27 chatbry sudo[1242]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:27 chatbry volumio[1033]: mount: /media/61BB-782A: special device /dev/sda1 does not exist. oct. 11 12:41:27 chatbry volumio[1033]: dmesg(1) may have more information after failed mount system call. oct. 11 12:41:27 chatbry volumio[1033]: error: Failed to mount 61BB-782A: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/61BB-782A" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 oct. 11 12:41:27 chatbry volumio[1033]: mount: /media/61BB-782A: special device /dev/sda1 does not exist. oct. 11 12:41:27 chatbry volumio[1033]: dmesg(1) may have more information after failed mount system call. oct. 11 12:41:27 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback oct. 11 12:41:27 chatbry volumio[1033]: info: Loading plugin "volumio_command_line_client"... oct. 11 12:41:27 chatbry kernel: ext3: Unknown parameter 'dmask' oct. 11 12:41:27 chatbry kernel: ext2: Unknown parameter 'dmask' oct. 11 12:41:27 chatbry kernel: ext4: Unknown parameter 'dmask' oct. 11 12:41:27 chatbry kernel: /dev/sda1: Can't lookup blockdev oct. 11 12:41:27 chatbry volumio[1033]: info: Loading plugin "upnp"... oct. 11 12:41:27 chatbry kernel: usb 1-1-port2: over-current change #9 oct. 11 12:41:27 chatbry volumio[1033]: info: [1791715287132] Starting Upmpd Daemon oct. 11 12:41:27 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback oct. 11 12:41:27 chatbry volumio[1033]: info: Loading plugin "my_music"... oct. 11 12:41:27 chatbry volumio[1033]: info: Loading plugin "mpd"... oct. 11 12:41:27 chatbry kernel: usb 1-1-port3: over-current change #8 oct. 11 12:41:27 chatbry kernel: usb 1-1.1-port3: over-current change #7 oct. 11 12:41:27 chatbry kernel: usb 1-1.1-port2: over-current change #8 oct. 11 12:41:27 chatbry volumio[1033]: info: Loading plugin "upnp_browser"... oct. 11 12:41:28 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 9 using dwc_otg oct. 11 12:41:28 chatbry kernel: usb 1-1.1.2: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 oct. 11 12:41:28 chatbry kernel: usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 oct. 11 12:41:28 chatbry kernel: usb 1-1.1.2: Product: SanDisk 3.2Gen1 oct. 11 12:41:28 chatbry kernel: usb 1-1.1.2: Manufacturer: USB oct. 11 12:41:28 chatbry kernel: usb 1-1.1.2: SerialNumber: 01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476 oct. 11 12:41:28 chatbry kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected oct. 11 12:41:28 chatbry kernel: scsi host0: usb-storage 1-1.1.2:1.0 oct. 11 12:41:28 chatbry volumio-remote-updater[636]: [2026-10-11 12:41:28] [connect] Successful connection oct. 11 12:41:29 chatbry kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6 oct. 11 12:41:29 chatbry kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 oct. 11 12:41:29 chatbry kernel: sd 0:0:0:0: [sda] 30081024 512-byte logical blocks: (15.4 GB/14.3 GiB) oct. 11 12:41:29 chatbry kernel: sd 0:0:0:0: [sda] Write Protect is off oct. 11 12:41:29 chatbry kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 oct. 11 12:41:29 chatbry kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA oct. 11 12:41:29 chatbry kernel: sda: sda1 oct. 11 12:41:29 chatbry kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk oct. 11 12:41:30 chatbry volumio[1033]: info: Starting UPNP Browser oct. 11 12:41:30 chatbry volumio[1033]: info: Loading plugin "alarm-clock"... oct. 11 12:41:30 chatbry volumio[1033]: info: Loading plugin "airplay_emulation"... oct. 11 12:41:30 chatbry volumio[1033]: info: Starting Shairport Sync oct. 11 12:41:30 chatbry volumio[1033]: info: Loading plugin "last_100"... oct. 11 12:41:30 chatbry volumio[1033]: info: Loading plugin "webradio"... oct. 11 12:41:31 chatbry volumio[1033]: info: Loading plugin "i2s_dacs"... oct. 11 12:41:31 chatbry volumio[1033]: info: I2S DAC not set, start Auto-detection oct. 11 12:41:31 chatbry volumio[1033]: info: Loading plugin "volumiodiscovery"... oct. 11 12:41:31 chatbry volumio[1033]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. oct. 11 12:41:31 chatbry volumio[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! oct. 11 12:41:31 chatbry volumio[1033]: *** WARNING *** For more information see oct. 11 12:41:31 chatbry volumio[1033]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. oct. 11 12:41:31 chatbry volumio[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! oct. 11 12:41:31 chatbry volumio[1033]: *** WARNING *** For more information see oct. 11 12:41:31 chatbry node[1033]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. oct. 11 12:41:31 chatbry node[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! oct. 11 12:41:31 chatbry node[1033]: *** WARNING *** For more information see oct. 11 12:41:31 chatbry node[1033]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. oct. 11 12:41:31 chatbry node[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! oct. 11 12:41:31 chatbry node[1033]: *** WARNING *** For more information see oct. 11 12:41:31 chatbry volumio[1033]: info: Applying required configuration parameters for plugin volumiodiscovery oct. 11 12:41:31 chatbry volumio[1033]: info: Discovery: Started advertising with name: Chatbry oct. 11 12:41:31 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback oct. 11 12:41:31 chatbry volumio[1033]: info: Loading plugin "autostart"... oct. 11 12:41:31 chatbry volumio[1033]: info: Applying required configuration parameters for plugin autostart oct. 11 12:41:31 chatbry volumio[1033]: info: AutoStart - onVolumioStart - read config.json oct. 11 12:41:31 chatbry volumio[1033]: info: Loading plugin "now_playing"... oct. 11 12:41:32 chatbry kernel: usb 1-1.1-port2: over-current change #9 oct. 11 12:41:32 chatbry kernel: usb 1-1-port2: over-current change #10 oct. 11 12:41:32 chatbry kernel: usb 1-1.1-port3: over-current change #8 oct. 11 12:41:32 chatbry kernel: usb 1-1-port3: over-current change #9 oct. 11 12:41:33 chatbry kernel: usb 1-1.1-port2: over-current change #10 oct. 11 12:41:33 chatbry kernel: usb 1-1-port4: over-current change #8 oct. 11 12:41:33 chatbry kernel: usb 1-1.1.2: USB disconnect, device number 9 oct. 11 12:41:33 chatbry systemd[1]: systemd-fsckd.service: Deactivated successfully. oct. 11 12:41:33 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 10 using dwc_otg oct. 11 12:41:33 chatbry kernel: usb 1-1.1.2: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 oct. 11 12:41:33 chatbry kernel: usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 oct. 11 12:41:33 chatbry kernel: usb 1-1.1.2: Product: SanDisk 3.2Gen1 oct. 11 12:41:33 chatbry kernel: usb 1-1.1.2: Manufacturer: USB oct. 11 12:41:33 chatbry kernel: usb 1-1.1.2: SerialNumber: 01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476 oct. 11 12:41:33 chatbry kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected oct. 11 12:41:33 chatbry kernel: scsi host0: usb-storage 1-1.1.2:1.0 oct. 11 12:41:35 chatbry kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6 oct. 11 12:41:35 chatbry kernel: scsi 0:0:0:0: Attached scsi generic sg0 type 0 oct. 11 12:41:35 chatbry kernel: sd 0:0:0:0: [sda] 30081024 512-byte logical blocks: (15.4 GB/14.3 GiB) oct. 11 12:41:35 chatbry kernel: sd 0:0:0:0: [sda] Write Protect is off oct. 11 12:41:35 chatbry kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 oct. 11 12:41:35 chatbry kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA oct. 11 12:41:35 chatbry kernel: sda: sda1 oct. 11 12:41:35 chatbry kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk oct. 11 12:41:35 chatbry volumio[1033]: info: Loading plugin "outputs"... oct. 11 12:41:35 chatbry volumio[1033]: info: Loading plugin "albumart"... oct. 11 12:41:36 chatbry volumio[1033]: info: Plugin example_plugin is not enabled oct. 11 12:41:36 chatbry volumio[1033]: info: Loading plugin "inputs"... oct. 11 12:41:36 chatbry volumio[1033]: info: Loading plugin "updater_comm"... oct. 11 12:41:36 chatbry volumio[1033]: info: Plugin mpdemulation is not enabled oct. 11 12:41:36 chatbry volumio[1033]: info: Loading plugin "rest_api"... oct. 11 12:41:36 chatbry volumio[1033]: info: Loading plugin "websocket"... oct. 11 12:41:36 chatbry volumio[1033]: info: Starting Socket.io Server version 1.7.4 oct. 11 12:41:36 chatbry volumio[1033]: info: Loading plugin "Systeminfo"... oct. 11 12:41:36 chatbry systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. oct. 11 12:41:36 chatbry systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. oct. 11 12:41:36 chatbry systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. oct. 11 12:41:37 chatbry upmpdcli[1285]: Could not open config: /tmp/upmpdcli.conf oct. 11 12:41:37 chatbry systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE oct. 11 12:41:37 chatbry systemd[1]: upmpdcli.service: Failed with result 'exit-code'. oct. 11 12:41:37 chatbry volumio[1275]: Forking 3 albumart workers oct. 11 12:41:37 chatbry volumio[1033]: info: Loading i18n strings for locale fr oct. 11 12:41:37 chatbry volumio[1033]: Updating browse sources language oct. 11 12:41:37 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources oct. 11 12:41:38 chatbry systemd[1]: systemd-hostnamed.service: Deactivated successfully. oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::initPlayerControls oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam oct. 11 12:41:40 chatbry volumio[1033]: Express server listening on port 3000 oct. 11 12:41:40 chatbry volumio[1033]: [Metrics] WebUI: 21s 236.10ms oct. 11 12:41:40 chatbry volumio[1033]: info: CoreStateMachine::resetVolumioState oct. 11 12:41:40 chatbry volumio[1033]: info: CoreStateMachine::getcurrentVolume oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::volumioRetrievevolume oct. 11 12:41:40 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:41:40 chatbry sudo[1324]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 oct. 11 12:41:40 chatbry sudo[1324]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:40 chatbry sudo[1324]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:40 chatbry sudo[1326]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 oct. 11 12:41:40 chatbry sudo[1326]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:40 chatbry sudo[1326]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:41 chatbry volumio[1033]: info: Volumio Network Manager: Network status updated: 1 oct. 11 12:41:41 chatbry volumio[1033]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-uuid/61BB-782A /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"32","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"61BB-782A","ID_FS_UUID_ENC":"61BB-782A","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"32","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"30080992","ID_PART_ENTRY_TYPE":"0xc","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"SanDisk_3.2Gen1","ID_USB_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_USB_MODEL_ID":"5583","ID_USB_REVISION":"1.00","ID_USB_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_USB_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_USB_TYPE":"disk","ID_USB_VENDOR":"USB","ID_USB_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_USB_VENDOR_ID":"0781","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2237","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"34688374"} oct. 11 12:41:41 chatbry sudo[1333]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 oct. 11 12:41:41 chatbry sudo[1333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:41 chatbry sudo[1333]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:41 chatbry volumio[1033]: umount: /dev/sda1: not mounted. oct. 11 12:41:41 chatbry volumio[1033]: error: Failed to umount 61BB-782A: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sda1" oct. 11 12:41:41 chatbry volumio[1033]: umount: /dev/sda1: not mounted. oct. 11 12:41:42 chatbry volumio[1033]: verbose: New Socket.io Connection to 192.168.1.64 from 192.168.1.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 oct. 11 12:41:42 chatbry volumio[1033]: verbose: New Socket.io Connection to chatbry.local from 192.168.1.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 oct. 11 12:41:42 chatbry volumio[1033]: info: VolumeController:: Volume=60 Mute =false oct. 11 12:41:42 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:41:42 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:42 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo oct. 11 12:41:42 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:41:42 chatbry volumio[1033]: info: CoreStateMachine::updateTrackBlock oct. 11 12:41:42 chatbry volumio[1033]: info: CorePlayQueue::getTrackBlock oct. 11 12:41:42 chatbry volumio[1033]: info: CoreCommandRouter::volumioRetrievevolume oct. 11 12:41:42 chatbry volumio[1033]: info: Reloading queue from file oct. 11 12:41:43 chatbry volumio[1033]: verbose: New Socket.io Connection to 192.168.1.64 from 192.168.1.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 oct. 11 12:41:43 chatbry volumio[1033]: info: CoreStateMachine::setRepeat false single undefined oct. 11 12:41:43 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:41:43 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:43 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo oct. 11 12:41:43 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:41:43 chatbry volumio[1033]: info: CoreStateMachine::setRandom false oct. 11 12:41:43 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:41:43 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:43 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo oct. 11 12:41:43 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:41:43 chatbry volumio[1033]: info: Setting Device type: Raspberry PI oct. 11 12:41:43 chatbry volumio[1033]: info: Mounting Device 61BB-782A oct. 11 12:41:43 chatbry volumio-remote-updater[636]: [2026-10-11 12:41:43] [connect] Successful connection oct. 11 12:41:43 chatbry sudo[1349]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/61BB-782A -o noatime,dmask=0000,fmask=0000,iocharset=utf8 oct. 11 12:41:43 chatbry sudo[1349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:44 chatbry kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! oct. 11 12:41:44 chatbry kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. oct. 11 12:41:44 chatbry sudo[1349]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:44 chatbry volumio[1033]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-uuid/61BB-782A /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"33","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"61BB-782A","ID_FS_UUID_ENC":"61BB-782A","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"32","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"30080992","ID_PART_ENTRY_TYPE":"0xc","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"SanDisk_3.2Gen1","ID_USB_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_USB_MODEL_ID":"5583","ID_USB_REVISION":"1.00","ID_USB_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_USB_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_USB_TYPE":"disk","ID_USB_VENDOR":"USB","ID_USB_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_USB_VENDOR_ID":"0781","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2281","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"45177853"} oct. 11 12:41:44 chatbry sudo[1357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 oct. 11 12:41:44 chatbry sudo[1357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:44 chatbry systemd[1]: media-61BB\x2d782A.mount: Deactivated successfully. oct. 11 12:41:44 chatbry sudo[1357]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:44 chatbry systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... oct. 11 12:41:45 chatbry volumio[1033]: info: Discovery: adding 9c0a4e48-fb30-4943-b9b0-01588af221b5 oct. 11 12:41:45 chatbry volumio[1033]: info: Discovery: Found device Chatbry oct. 11 12:41:45 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetState oct. 11 12:41:45 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:45 chatbry sudo[1376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service oct. 11 12:41:45 chatbry sudo[1376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:45 chatbry volumio[1033]: verbose: New Socket.io Connection to chatbry.local from 192.168.1.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 oct. 11 12:41:45 chatbry volumio[1033]: verbose: New Socket.io Connection to 192.168.1.64 from 192.168.1.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 oct. 11 12:41:45 chatbry volumio[1033]: info: VolumeController:: Volume=60 Mute =false oct. 11 12:41:45 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:41:45 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:45 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:41:45 chatbry volumio[1033]: verbose: New Socket.io Connection to 192.168.1.64 from 192.168.1.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 oct. 11 12:41:45 chatbry volumio[1033]: verbose: New Socket.io Connection to 192.168.1.64 from 192.168.1.19 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 oct. 11 12:41:46 chatbry volumio[1033]: MPD error: Connection refused oct. 11 12:41:46 chatbry volumio[1033]: info: Mounting Device 61BB-782A oct. 11 12:41:46 chatbry systemd[1]: setdatetime-helper.service: Deactivated successfully. oct. 11 12:41:46 chatbry systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. oct. 11 12:41:46 chatbry systemd[1]: setdatetime-helper.service: Consumed 1.108s CPU time. oct. 11 12:41:46 chatbry sudo[1406]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/61BB-782A -o noatime,dmask=0000,fmask=0000,iocharset=utf8 oct. 11 12:41:46 chatbry sudo[1406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:46 chatbry kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! oct. 11 12:41:46 chatbry kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. oct. 11 12:41:46 chatbry sudo[1406]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:46 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetState oct. 11 12:41:46 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:46 chatbry volumio[1033]: info: Discovery: this is already registered, 9c0a4e48-fb30-4943-b9b0-01588af221b5 oct. 11 12:41:46 chatbry volumio[1033]: info: Discovery: Found device Chatbry oct. 11 12:41:46 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetState oct. 11 12:41:46 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:47 chatbry volumio-remote-updater[636]: [2026-10-11 12:41:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1791715303 101 oct. 11 12:41:47 chatbry volumio[1033]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 8 oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetQueue oct. 11 12:41:47 chatbry volumio[1033]: info: CoreStateMachine::getQueue oct. 11 12:41:47 chatbry volumio[1033]: info: CorePlayQueue::getQueue oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel oct. 11 12:41:47 chatbry volumio[1033]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction oct. 11 12:41:47 chatbry volumio[1033]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs oct. 11 12:41:47 chatbry volumio[1033]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetState oct. 11 12:41:47 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:41:47 chatbry volumio[1033]: info: Completed loading Core Plugins oct. 11 12:41:47 chatbry volumio[1033]: info: Preparing to generate the ALSA configuration file oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetVisibleSources oct. 11 12:41:47 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources oct. 11 12:41:48 chatbry volumio[1033]: info: Listing playlists oct. 11 12:41:48 chatbry volumio[1033]: MPD error: Connection refused oct. 11 12:41:48 chatbry volumio[1033]: info: Asound.conf file unchanged, so no further update is needed oct. 11 12:41:48 chatbry volumio[1033]: info: Output device has changed, restarting MPD oct. 11 12:41:48 chatbry volumio[1033]: info: Output device has changed, restarting Shairport Sync oct. 11 12:41:48 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:48 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:41:48 chatbry sudo[1419]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf oct. 11 12:41:49 chatbry sudo[1419]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:49 chatbry volumio[1286]: Starting albumart workers oct. 11 12:41:49 chatbry sudo[1421]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service oct. 11 12:41:49 chatbry sudo[1419]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:49 chatbry sudo[1421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:49 chatbry volumio[1033]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 oct. 11 12:41:49 chatbry volumio[1033]: info: ___________ START PLUGINS ___________ oct. 11 12:41:49 chatbry volumio[1033]: info: ControllerMpd::onStart: Initializing MPD oct. 11 12:41:49 chatbry volumio[1033]: info: Creating MPD Configuration file oct. 11 12:41:49 chatbry systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. oct. 11 12:41:49 chatbry systemd[1]: Starting mpd.service - Music Player Daemon... oct. 11 12:41:49 chatbry volumio[1288]: Starting albumart workers oct. 11 12:41:49 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam oct. 11 12:41:49 chatbry volumio[1033]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] oct. 11 12:41:49 chatbry volumio[1033]: info: [1791715309451] CoreMusicLibrary::Adding element Serveurs Média oct. 11 12:41:49 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources oct. 11 12:41:49 chatbry sudo[1431]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log oct. 11 12:41:49 chatbry sudo[1431]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) oct. 11 12:41:49 chatbry sudo[1434]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory oct. 11 12:41:49 chatbry sudo[1431]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:49 chatbry sudo[1430]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf oct. 11 12:41:49 chatbry sudo[1430]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:49 chatbry sudo[1430]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:49 chatbry volumio[1287]: Starting albumart workers oct. 11 12:41:49 chatbry volumio[1033]: info: UPNP Browser: Client initialized successfully oct. 11 12:41:49 chatbry sudo[1433]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service oct. 11 12:41:49 chatbry sudo[1433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:41:49 chatbry systemd[1]: mpd.service: Deactivated successfully. oct. 11 12:41:49 chatbry systemd[1]: Stopped mpd.service - Music Player Daemon. oct. 11 12:41:49 chatbry systemd[1]: mpd.socket: Deactivated successfully. oct. 11 12:41:49 chatbry systemd[1]: Closed mpd.socket - Music Player Daemon Socket. oct. 11 12:41:49 chatbry systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... oct. 11 12:41:49 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:49 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:41:50 chatbry systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. oct. 11 12:41:50 chatbry systemd[1]: Starting mpd.service - Music Player Daemon... oct. 11 12:41:50 chatbry sudo[1441]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log oct. 11 12:41:50 chatbry sudo[1441]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) oct. 11 12:41:50 chatbry sudo[1444]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory oct. 11 12:41:50 chatbry sudo[1441]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:50 chatbry volumio[1033]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 oct. 11 12:41:50 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:50 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:41:50 chatbry volumio[1033]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 oct. 11 12:41:50 chatbry volumio[1033]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] oct. 11 12:41:50 chatbry volumio[1033]: info: [1791715310604] CoreMusicLibrary::Adding element Last_100 oct. 11 12:41:50 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources oct. 11 12:41:50 chatbry volumio[1033]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] oct. 11 12:41:50 chatbry volumio[1033]: info: [1791715310642] CoreMusicLibrary::Adding element Webradio oct. 11 12:41:50 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources oct. 11 12:41:50 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion oct. 11 12:41:50 chatbry volumio[1033]: info: Initializing BBC Radios oct. 11 12:41:51 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion oct. 11 12:41:51 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:41:51 chatbry volumio[1033]: info: AutoStart - onStart - waiting for system ready state oct. 11 12:41:51 chatbry volumio[1033]: info: AutoStart - Polling config: interval=10000ms, maxAttempts=20 oct. 11 12:41:51 chatbry volumio[1033]: info: AutoStart - Maximum wait time: 200 seconds oct. 11 12:41:51 chatbry volumio[1033]: info: AutoStart - Startup volume enabled, level=60 oct. 11 12:41:51 chatbry volumio[1033]: info: AutoStart - Check #1/20 - VOLUMIO_SYSTEM_STATUS = starting oct. 11 12:41:51 chatbry volumio[1033]: info: [now-playing] ConfigUpdater: config is up to date. oct. 11 12:41:51 chatbry volumio[1033]: info: Cannot retrieve data for calling home oct. 11 12:41:52 chatbry systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. oct. 11 12:41:52 chatbry systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. oct. 11 12:41:52 chatbry systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. oct. 11 12:41:52 chatbry sudo[1376]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:55 chatbry volumio[1033]: info: [now-playing] App is listening on port 4004. oct. 11 12:41:55 chatbry volumio[1033]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds oct. 11 12:41:56 chatbry volumio[1033]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/61BB-782A oct. 11 12:41:57 chatbry volumio[1033]: info: MPD Permissions set oct. 11 12:41:57 chatbry volumio[1033]: info: MPD Permissions set oct. 11 12:41:57 chatbry volumio[1033]: info: Upmpdcli Daemon Started oct. 11 12:41:58 chatbry mpd[1445]: 2026-10-11T12:41:58 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg oct. 11 12:41:58 chatbry systemd[1]: Started mpd.service - Music Player Daemon. oct. 11 12:41:58 chatbry sudo[1433]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:58 chatbry sudo[1421]: pam_unix(sudo:session): session closed for user root oct. 11 12:41:58 chatbry volumio[1033]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:41:58 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:41:59 chatbry volumio[1033]: info: Completed starting Core Plugins oct. 11 12:41:59 chatbry volumio[1033]: info: ------------------------------------------- oct. 11 12:41:59 chatbry volumio[1033]: info: ----- MyVolumio plugins startup ---- oct. 11 12:41:59 chatbry volumio[1033]: info: ------------------------------------------- oct. 11 12:41:59 chatbry volumio[1033]: info: [MyVolumio PluginManager] Fetching plans data.... oct. 11 12:41:59 chatbry volumio[1033]: error: MPD error: The expression evaluated to a falsy value: oct. 11 12:41:59 chatbry volumio[1033]: assert.ok(self.idling) oct. 11 12:41:59 chatbry volumio[1033]: error: The expression evaluated to a falsy value: oct. 11 12:41:59 chatbry volumio[1033]: assert.ok(self.idling) oct. 11 12:41:59 chatbry volumio[1033]: info: Starting Shairport Sync oct. 11 12:41:59 chatbry volumio[1033]: info: Starting Shairport Sync oct. 11 12:41:59 chatbry volumio[1033]: info: Starting Shairport Sync oct. 11 12:42:00 chatbry volumio[1033]: error: updateQueue error: null oct. 11 12:42:00 chatbry volumio[1033]: info: MPD running with PID1445 oct. 11 12:42:00 chatbry volumio[1033]: ,establishing connection oct. 11 12:42:00 chatbry sudo[1527]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync oct. 11 12:42:00 chatbry sudo[1527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:00 chatbry sudo[1529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync oct. 11 12:42:00 chatbry sudo[1529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:00 chatbry sudo[1531]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync oct. 11 12:42:00 chatbry sudo[1531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:00 chatbry systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... oct. 11 12:42:00 chatbry systemd[1]: shairport-sync.service: Deactivated successfully. oct. 11 12:42:00 chatbry systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. oct. 11 12:42:00 chatbry systemd[1]: shairport-sync.service: Consumed 1.903s CPU time. oct. 11 12:42:00 chatbry volumio[1033]: error: updateQueue error: null oct. 11 12:42:00 chatbry systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. oct. 11 12:42:00 chatbry sudo[1527]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:00 chatbry systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... oct. 11 12:42:00 chatbry systemd[1]: shairport-sync.service: Deactivated successfully. oct. 11 12:42:00 chatbry systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. oct. 11 12:42:00 chatbry systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. oct. 11 12:42:00 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetState oct. 11 12:42:00 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:00 chatbry sudo[1529]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:00 chatbry sudo[1531]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:00 chatbry volumio[1033]: info: Shairport-Sync Started oct. 11 12:42:00 chatbry volumio[1033]: Error adding Membership: Error: addMembership EINVAL oct. 11 12:42:00 chatbry volumio[1033]: info: Shairport-Sync Started oct. 11 12:42:00 chatbry volumio[1033]: info: Shairport-Sync Started oct. 11 12:42:01 chatbry volumio[1033]: info: AutoStart - Check #2/20 - VOLUMIO_SYSTEM_STATUS = starting oct. 11 12:42:02 chatbry sudo[1552]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service oct. 11 12:42:02 chatbry sudo[1552]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:02 chatbry sudo[1555]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service oct. 11 12:42:02 chatbry sudo[1555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:02 chatbry systemd[1]: Started mpd_monitor.service - MPD Monitor Service. oct. 11 12:42:02 chatbry mpd_monitor.sh[1556]: MPD Monitor Service: Starting MPD Monitor Service oct. 11 12:42:02 chatbry sudo[1552]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:02 chatbry systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... oct. 11 12:42:02 chatbry systemd[1]: mpd_monitor.service: Deactivated successfully. oct. 11 12:42:02 chatbry volumio[1033]: info: Successfully started MPD Monitor oct. 11 12:42:02 chatbry systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. oct. 11 12:42:02 chatbry systemd[1]: Started mpd_monitor.service - MPD Monitor Service. oct. 11 12:42:02 chatbry mpd_monitor.sh[1561]: MPD Monitor Service: Starting MPD Monitor Service oct. 11 12:42:02 chatbry sudo[1555]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:02 chatbry volumio[1033]: info: Successfully started MPD Monitor oct. 11 12:42:03 chatbry kernel: usb 1-1.1-port2: over-current change #11 oct. 11 12:42:03 chatbry kernel: usb 1-1-port2: over-current change #11 oct. 11 12:42:03 chatbry kernel: usb 1-1.1-port3: over-current change #9 oct. 11 12:42:03 chatbry kernel: usb 1-1-port3: over-current change #10 oct. 11 12:42:03 chatbry kernel: usb 1-1-port4: over-current change #9 oct. 11 12:42:03 chatbry kernel: usb 1-1-port2: over-current change #12 oct. 11 12:42:04 chatbry kernel: usb 1-1.1-port2: over-current change #12 oct. 11 12:42:04 chatbry kernel: usb 1-1-port3: over-current change #11 oct. 11 12:42:04 chatbry kernel: usb 1-1.1.2: USB disconnect, device number 10 oct. 11 12:42:04 chatbry kernel: sda: detected capacity change from 30081024 to 0 oct. 11 12:42:04 chatbry kernel: usb 1-1-port4: over-current change #10 oct. 11 12:42:04 chatbry kernel: usb 1-1.1-port3: over-current change #10 oct. 11 12:42:04 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 11 using dwc_otg oct. 11 12:42:04 chatbry kernel: usb 1-1-port2: over-current change #13 oct. 11 12:42:05 chatbry kernel: usb 1-1-port3: over-current change #12 oct. 11 12:42:05 chatbry kernel: usb 1-1-port4: over-current change #11 oct. 11 12:42:05 chatbry kernel: usb 1-1.1-port3: over-current change #11 oct. 11 12:42:05 chatbry kernel: usb 1-1.1-port2: over-current change #13 oct. 11 12:42:06 chatbry volumio[1033]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-uuid/61BB-782A /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"35","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"61BB-782A","ID_FS_UUID_ENC":"61BB-782A","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"32","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"30080992","ID_PART_ENTRY_TYPE":"0xc","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"SanDisk_3.2Gen1","ID_USB_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_USB_MODEL_ID":"5583","ID_USB_REVISION":"1.00","ID_USB_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_USB_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_USB_TYPE":"disk","ID_USB_VENDOR":"USB","ID_USB_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_USB_VENDOR_ID":"0781","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2326","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"50833032"} oct. 11 12:42:06 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 12 using dwc_otg oct. 11 12:42:06 chatbry sudo[1594]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 oct. 11 12:42:06 chatbry sudo[1594]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:06 chatbry kernel: usb 1-1-port2: over-current change #14 oct. 11 12:42:06 chatbry systemd[1]: media-61BB\x2d782A.mount: Deactivated successfully. oct. 11 12:42:06 chatbry sudo[1594]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:06 chatbry kernel: usb 1-1-port3: over-current change #13 oct. 11 12:42:06 chatbry kernel: usb 1-1-port4: over-current change #12 oct. 11 12:42:07 chatbry kernel: usb 1-1.1-port3: over-current change #12 oct. 11 12:42:07 chatbry kernel: usb 1-1.1-port2: over-current change #14 oct. 11 12:42:07 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 13 using dwc_otg oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar oct. 11 12:42:07 chatbry kernel: usb 1-1.1.2: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 oct. 11 12:42:07 chatbry kernel: usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 oct. 11 12:42:07 chatbry kernel: usb 1-1.1.2: Product: SanDisk 3.2Gen1 oct. 11 12:42:07 chatbry kernel: usb 1-1.1.2: Manufacturer: USB oct. 11 12:42:07 chatbry kernel: usb 1-1.1.2: SerialNumber: 01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476 oct. 11 12:42:07 chatbry kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected oct. 11 12:42:07 chatbry kernel: scsi host0: usb-storage 1-1.1.2:1.0 oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso oct. 11 12:42:07 chatbry volumio[1033]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso oct. 11 12:42:08 chatbry volumio[1033]: info: Adding plugin bluetooth to MyMusic Plugins oct. 11 12:42:08 chatbry volumio[1033]: info: Adding plugin multiroom to MyMusic Plugins oct. 11 12:42:08 chatbry volumio[1033]: info: Adding plugin metavolumio to MyMusic Plugins oct. 11 12:42:08 chatbry volumio[1033]: info: Adding plugin cd_controller to MyMusic Plugins oct. 11 12:42:08 chatbry volumio[1033]: info: Adding plugin qobuzconnect to MyMusic Plugins oct. 11 12:42:08 chatbry volumio[1033]: info: Adding plugin smart_inputs to MyMusic Plugins oct. 11 12:42:08 chatbry volumio[1033]: info: Adding plugin tidalconnect to MyMusic Plugins oct. 11 12:42:08 chatbry volumio[1033]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... oct. 11 12:42:08 chatbry kernel: usb 1-1.1-port2: over-current change #15 oct. 11 12:42:08 chatbry kernel: usb 1-1-port2: over-current change #15 oct. 11 12:42:08 chatbry kernel: usb 1-1.1-port3: over-current change #13 oct. 11 12:42:08 chatbry kernel: usb 1-1-port3: over-current change #14 oct. 11 12:42:09 chatbry kernel: usb 1-1-port4: over-current change #13 oct. 11 12:42:09 chatbry kernel: usb 1-1-port4: over-current condition oct. 11 12:42:09 chatbry kernel: usb 1-1-port2: over-current change #16 oct. 11 12:42:09 chatbry kernel: usb 1-1-port3: over-current change #15 oct. 11 12:42:09 chatbry kernel: usb 1-1-port4: over-current change #14 oct. 11 12:42:10 chatbry kernel: usb 1-1.1-port2: over-current change #16 oct. 11 12:42:10 chatbry kernel: usb 1-1.1.2: USB disconnect, device number 13 oct. 11 12:42:10 chatbry kernel: usb 1-1.1-port3: over-current change #14 oct. 11 12:42:10 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 14 using dwc_otg oct. 11 12:42:10 chatbry kernel: usb 1-1.1.2: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 oct. 11 12:42:10 chatbry kernel: usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 oct. 11 12:42:10 chatbry kernel: usb 1-1.1.2: Product: SanDisk 3.2Gen1 oct. 11 12:42:10 chatbry kernel: usb 1-1.1.2: Manufacturer: USB oct. 11 12:42:10 chatbry kernel: usb 1-1.1.2: SerialNumber: 01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476 oct. 11 12:42:10 chatbry kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected oct. 11 12:42:10 chatbry kernel: scsi host0: usb-storage 1-1.1.2:1.0 oct. 11 12:42:11 chatbry kernel: usb 1-1.1-port2: over-current change #17 oct. 11 12:42:11 chatbry kernel: usb 1-1-port2: over-current change #17 oct. 11 12:42:11 chatbry kernel: usb 1-1.1-port3: over-current change #15 oct. 11 12:42:11 chatbry kernel: usb 1-1-port3: over-current change #16 oct. 11 12:42:11 chatbry kernel: usb 1-1-port4: over-current change #15 oct. 11 12:42:11 chatbry kernel: usb 1-1.1.2: USB disconnect, device number 14 oct. 11 12:42:12 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 15 using dwc_otg oct. 11 12:42:12 chatbry kernel: usb 1-1.1.2: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 oct. 11 12:42:12 chatbry kernel: usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 oct. 11 12:42:12 chatbry kernel: usb 1-1.1.2: Product: SanDisk 3.2Gen1 oct. 11 12:42:12 chatbry kernel: usb 1-1.1.2: Manufacturer: USB oct. 11 12:42:12 chatbry kernel: usb 1-1.1.2: SerialNumber: 01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476 oct. 11 12:42:12 chatbry kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected oct. 11 12:42:12 chatbry kernel: scsi host0: usb-storage 1-1.1.2:1.0 oct. 11 12:42:12 chatbry kernel: usb 1-1-port2: over-current change #18 oct. 11 12:42:12 chatbry kernel: usb 1-1.1-port2: over-current change #18 oct. 11 12:42:12 chatbry kernel: usb 1-1-port3: over-current change #17 oct. 11 12:42:12 chatbry kernel: usb 1-1.1-port3: over-current change #16 oct. 11 12:42:12 chatbry kernel: usb 1-1-port4: over-current change #16 oct. 11 12:42:13 chatbry kernel: usb 1-1.1-port2: over-current change #19 oct. 11 12:42:13 chatbry kernel: usb 1-1-port2: over-current change #19 oct. 11 12:42:13 chatbry kernel: usb 1-1.1-port3: over-current change #17 oct. 11 12:42:13 chatbry kernel: usb 1-1-port3: over-current change #18 oct. 11 12:42:13 chatbry kernel: usb 1-1-port4: over-current change #17 oct. 11 12:42:14 chatbry kernel: usb 1-1.1.2: reset high-speed USB device number 15 using dwc_otg oct. 11 12:42:14 chatbry kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6 oct. 11 12:42:14 chatbry kernel: scsi 0:0:0:0: Attached scsi generic sg0 type 0 oct. 11 12:42:14 chatbry kernel: sd 0:0:0:0: [sda] 30081024 512-byte logical blocks: (15.4 GB/14.3 GiB) oct. 11 12:42:14 chatbry kernel: sd 0:0:0:0: [sda] Write Protect is off oct. 11 12:42:14 chatbry kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 oct. 11 12:42:14 chatbry kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA oct. 11 12:42:14 chatbry kernel: sda: sda1 oct. 11 12:42:14 chatbry kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk oct. 11 12:42:15 chatbry kernel: usb 1-1.1-port2: over-current change #20 oct. 11 12:42:15 chatbry kernel: usb 1-1-port2: over-current change #20 oct. 11 12:42:16 chatbry kernel: usb 1-1.1-port3: over-current change #18 oct. 11 12:42:16 chatbry kernel: usb 1-1-port3: over-current change #19 oct. 11 12:42:16 chatbry kernel: usb 1-1-port4: over-current change #18 oct. 11 12:42:16 chatbry kernel: usb 1-1-port2: over-current change #21 oct. 11 12:42:16 chatbry kernel: usb 1-1-port3: over-current change #20 oct. 11 12:42:17 chatbry kernel: usb 1-1-port4: over-current change #19 oct. 11 12:42:17 chatbry kernel: usb 1-1.1-port2: over-current change #21 oct. 11 12:42:17 chatbry kernel: usb 1-1-port2: over-current change #22 oct. 11 12:42:17 chatbry kernel: usb 1-1.1.2: USB disconnect, device number 15 oct. 11 12:42:17 chatbry kernel: sda: detected capacity change from 30081024 to 0 oct. 11 12:42:17 chatbry kernel: usb 1-1-port3: over-current change #21 oct. 11 12:42:17 chatbry kernel: usb 1-1.1-port3: over-current change #19 oct. 11 12:42:18 chatbry kernel: usb 1-1-port4: over-current change #20 oct. 11 12:42:18 chatbry volumio[1033]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded oct. 11 12:42:18 chatbry volumio[1033]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio oct. 11 12:42:18 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 16 using dwc_otg oct. 11 12:42:18 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:18 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:18 chatbry volumio[1033]: info: Starting MyVolumio Remote Streaming Endpoints oct. 11 12:42:18 chatbry kernel: usb 1-1-port2: over-current change #23 oct. 11 12:42:18 chatbry volumio[1033]: info: MyVolumio login type: Token oct. 11 12:42:18 chatbry kernel: usb 1-1-port3: over-current change #22 oct. 11 12:42:19 chatbry kernel: usb 1-1-port4: over-current change #21 oct. 11 12:42:19 chatbry volumio[1033]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started oct. 11 12:42:19 chatbry volumio[1033]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... oct. 11 12:42:19 chatbry kernel: usb 1-1.1-port3: over-current change #20 oct. 11 12:42:19 chatbry kernel: usb 1-1.1-port2: over-current change #22 oct. 11 12:42:19 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 17 using dwc_otg oct. 11 12:42:19 chatbry kernel: usb 1-1-port2: over-current change #24 oct. 11 12:42:20 chatbry kernel: usb 1-1-port3: over-current change #23 oct. 11 12:42:20 chatbry kernel: usb 1-1-port4: over-current change #22 oct. 11 12:42:20 chatbry kernel: usb 1-1-port2: over-current change #25 oct. 11 12:42:20 chatbry kernel: usb 1-1.1-port3: over-current change #21 oct. 11 12:42:20 chatbry kernel: usb 1-1.1-port2: over-current change #23 oct. 11 12:42:20 chatbry kernel: usb 1-1-port3: over-current change #24 oct. 11 12:42:20 chatbry kernel: usb 1-1-port4: over-current change #23 oct. 11 12:42:21 chatbry kernel: usb 1-1.1.2: new high-speed USB device number 18 using dwc_otg oct. 11 12:42:21 chatbry kernel: usb 1-1.1.2: New USB device found, idVendor=0781, idProduct=5583, bcdDevice= 1.00 oct. 11 12:42:21 chatbry kernel: usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 oct. 11 12:42:21 chatbry kernel: usb 1-1.1.2: Product: SanDisk 3.2Gen1 oct. 11 12:42:21 chatbry kernel: usb 1-1.1.2: Manufacturer: USB oct. 11 12:42:21 chatbry kernel: usb 1-1.1.2: SerialNumber: 01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476 oct. 11 12:42:21 chatbry kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected oct. 11 12:42:21 chatbry kernel: scsi host0: usb-storage 1-1.1.2:1.0 oct. 11 12:42:22 chatbry kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6 oct. 11 12:42:22 chatbry kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 oct. 11 12:42:22 chatbry kernel: sd 0:0:0:0: [sda] 30081024 512-byte logical blocks: (15.4 GB/14.3 GiB) oct. 11 12:42:22 chatbry kernel: sd 0:0:0:0: [sda] Write Protect is off oct. 11 12:42:22 chatbry kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 oct. 11 12:42:22 chatbry kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA oct. 11 12:42:22 chatbry kernel: sda: sda1 oct. 11 12:42:22 chatbry kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk oct. 11 12:42:23 chatbry upmpdcli[1628]: writing RSA key oct. 11 12:42:28 chatbry volumio[1033]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded oct. 11 12:42:28 chatbry volumio[1033]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services oct. 11 12:42:28 chatbry volumio[1033]: info: Streaming services startup oct. 11 12:42:28 chatbry volumio[1033]: info: Starting Streaming Daemon oct. 11 12:42:28 chatbry volumio[1033]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started oct. 11 12:42:28 chatbry sudo[1649]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service oct. 11 12:42:28 chatbry sudo[1649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:28 chatbry sudo[1649]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:28 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion oct. 11 12:42:28 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:28 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled oct. 11 12:42:28 chatbry volumio[1033]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/61BB-782A oct. 11 12:42:28 chatbry volumio[1033]: info: AutoStart - Check #3/20 - VOLUMIO_SYSTEM_STATUS = starting oct. 11 12:42:29 chatbry volumio[1033]: error: Cannot start Volumio Streaming Daemon oct. 11 12:42:29 chatbry volumio[1033]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service oct. 11 12:42:29 chatbry volumio[1033]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. oct. 11 12:42:29 chatbry volumio[1033]: info: Mounting Device 61BB-782A oct. 11 12:42:29 chatbry sudo[1664]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/61BB-782A -o noatime,dmask=0000,fmask=0000,iocharset=utf8 oct. 11 12:42:29 chatbry sudo[1664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:29 chatbry kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! oct. 11 12:42:29 chatbry kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. oct. 11 12:42:29 chatbry sudo[1664]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:29 chatbry volumio[1033]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-uuid/61BB-782A /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"37","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"61BB-782A","ID_FS_UUID_ENC":"61BB-782A","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5583","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"32","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"30080992","ID_PART_ENTRY_TYPE":"0xc","ID_PART_TABLE_TYPE":"dos","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"SanDisk_3.2Gen1","ID_USB_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_USB_MODEL_ID":"5583","ID_USB_REVISION":"1.00","ID_USB_SERIAL":"USB_SanDisk_3.2Gen1_01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476-0:0","ID_USB_SERIAL_SHORT":"01013b4448e2dcc08568365f6cd7151c03b2c387959f52d735ad3896060b8aff90b3000000000000000000005401fdabff0b4a008355810717b0c476","ID_USB_TYPE":"disk","ID_USB_VENDOR":"USB","ID_USB_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_USB_VENDOR_ID":"0781","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2437","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"90047355"} oct. 11 12:42:29 chatbry sudo[1669]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 oct. 11 12:42:29 chatbry sudo[1669]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:29 chatbry systemd[1]: media-61BB\x2d782A.mount: Deactivated successfully. oct. 11 12:42:29 chatbry sudo[1669]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:30 chatbry volumio[1033]: info: Scanning new location : "USB/61BB-782A" oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: info: oct. 11 12:42:30 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:30 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: info: oct. 11 12:42:30 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:30 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: info: oct. 11 12:42:30 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:30 chatbry volumio[1033]: info: MPD Database updated - AlbumList cache refreshed oct. 11 12:42:30 chatbry volumio[1033]: info: oct. 11 12:42:30 chatbry volumio[1033]: ---------------------------- MPD announces state update: database oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: info: oct. 11 12:42:30 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:30 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: info: sendMpdCommand status took 35 milliseconds oct. 11 12:42:30 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:30 chatbry volumio[1033]: info: sendMpdCommand status took 35 milliseconds oct. 11 12:42:30 chatbry volumio[1033]: info: sendMpdCommand status took 38 milliseconds oct. 11 12:42:30 chatbry volumio[1033]: info: sendMpdCommand status took 35 milliseconds oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:30 chatbry volumio[1033]: info: Command Router : Notfying DB Updatefalse oct. 11 12:42:30 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:30 chatbry volumio[1033]: info: Command Router : Notfying DB Updatefalse oct. 11 12:42:30 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:30 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:30 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:30 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:30 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:30 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:30 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:30 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:30 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:30 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:30 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:30 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:30 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:30 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:30 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:30 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:30 chatbry volumio[1033]: info: ------------------------------ 446ms oct. 11 12:42:30 chatbry volumio[1033]: info: ------------------------------ 451ms oct. 11 12:42:31 chatbry volumio[1033]: info: Mounting Device 61BB-782A oct. 11 12:42:31 chatbry sudo[1689]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/61BB-782A -o noatime,dmask=0000,fmask=0000,iocharset=utf8 oct. 11 12:42:31 chatbry sudo[1689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) oct. 11 12:42:31 chatbry kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! oct. 11 12:42:31 chatbry kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. oct. 11 12:42:31 chatbry sudo[1689]: pam_unix(sudo:session): session closed for user root oct. 11 12:42:31 chatbry volumio[1033]: info: MPD Database updated - AlbumList cache refreshed oct. 11 12:42:31 chatbry volumio[1033]: info: oct. 11 12:42:31 chatbry volumio[1033]: ---------------------------- MPD announces state update: database oct. 11 12:42:31 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:31 chatbry volumio[1033]: info: oct. 11 12:42:31 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:31 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:31 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:31 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:31 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:31 chatbry volumio[1033]: info: MPD Database updated - AlbumList cache refreshed oct. 11 12:42:31 chatbry volumio[1033]: info: oct. 11 12:42:31 chatbry volumio[1033]: ---------------------------- MPD announces state update: database oct. 11 12:42:31 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:31 chatbry volumio[1033]: info: oct. 11 12:42:31 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:31 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:31 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:31 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:31 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 1280 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 1273 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 1268 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 1261 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 1257 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 55 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 54 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 54 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 52 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: info: sendMpdCommand status took 94 milliseconds oct. 11 12:42:31 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:31 chatbry volumio[1033]: info: Command Router : Notfying DB Updatefalse oct. 11 12:42:31 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: info: Command Router : Notfying DB Updatefalse oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: info: Command Router : Notfying DB Updatefalse oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: info: Command Router : Notfying DB Updatefalse oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:32 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:32 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:32 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:32 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:32 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:32 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:32 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:32 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:32 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:32 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:32 chatbry volumio[1033]: info: ------------------------------ 2219ms oct. 11 12:42:32 chatbry volumio[1033]: info: ------------------------------ 2212ms oct. 11 12:42:32 chatbry volumio[1033]: info: ------------------------------ 2213ms oct. 11 12:42:32 chatbry volumio[1033]: info: ------------------------------ 995ms oct. 11 12:42:32 chatbry volumio[1033]: info: ------------------------------ 1014ms oct. 11 12:42:32 chatbry volumio[1033]: info: ------------------------------ 1012ms oct. 11 12:42:33 chatbry volumio[1033]: info: sendMpdCommand status took 1408 milliseconds oct. 11 12:42:33 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:33 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:33 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:33 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:33 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:33 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:33 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:33 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:33 chatbry volumio[1033]: info: ------------------------------ 1518ms oct. 11 12:42:33 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings oct. 11 12:42:33 chatbry volumio-remote-updater[636]: Test mode disabled oct. 11 12:42:33 chatbry volumio-remote-updater[636]: Alpha mode disabled oct. 11 12:42:33 chatbry volumio-remote-updater[636]: Alpha legacy test mode disabled oct. 11 12:42:33 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled oct. 11 12:42:34 chatbry volumio[1033]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN oct. 11 12:42:34 chatbry volumio[1033]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} oct. 11 12:42:34 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache oct. 11 12:42:34 chatbry volumio[1033]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/61BB-782A oct. 11 12:42:34 chatbry volumio[1033]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 oct. 11 12:42:35 chatbry volumio[1033]: info: Scanning removed location : "USB/61BB-782A" oct. 11 12:42:35 chatbry volumio[1033]: info: MyVolumio token set successfully oct. 11 12:42:35 chatbry volumio[1033]: info: MYVOLUMIO: Adding device oct. 11 12:42:35 chatbry volumio[1033]: info: MYVOLUMIO: Evaluating Server oct. 11 12:42:35 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:35 chatbry volumio[1033]: info: oct. 11 12:42:35 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:35 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:35 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:35 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:35 chatbry volumio[1033]: info: oct. 11 12:42:35 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:35 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:35 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:35 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:35 chatbry volumio[1033]: info: oct. 11 12:42:35 chatbry volumio[1033]: ---------------------------- MPD announces state update: update oct. 11 12:42:35 chatbry volumio[1033]: info: ControllerMpd::getState oct. 11 12:42:35 chatbry volumio[1033]: verbose: ControllerMpd::sendMpdCommand status oct. 11 12:42:35 chatbry volumio[1033]: info: sendMpdCommand status took 12 milliseconds oct. 11 12:42:35 chatbry volumio[1033]: info: sendMpdCommand status took 9 milliseconds oct. 11 12:42:35 chatbry volumio[1033]: info: sendMpdCommand status took 6 milliseconds oct. 11 12:42:35 chatbry volumio[1033]: info: sendMpdCommand status took 5 milliseconds oct. 11 12:42:35 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:36 chatbry volumio[1033]: info: Command Router : Notfying DB Updatetrue oct. 11 12:42:36 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:36 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:36 chatbry volumio[1033]: info: Command Router : Notfying DB Updatetrue oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:36 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:36 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:36 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:36 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:36 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:36 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:36 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:36 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:36 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:36 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:36 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:36 chatbry volumio[1033]: info: ------------------------------ 145ms oct. 11 12:42:36 chatbry volumio[1033]: info: ------------------------------ 140ms oct. 11 12:42:36 chatbry volumio[1033]: info: sendMpdCommand status took 141 milliseconds oct. 11 12:42:36 chatbry volumio[1033]: info: sendMpdCommand status took 139 milliseconds oct. 11 12:42:36 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:36 chatbry volumio[1033]: info: Command Router : Notfying DB Updatetrue oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::Close All Modals sent oct. 11 12:42:36 chatbry volumio[1033]: verbose: ControllerMpd::parseState oct. 11 12:42:36 chatbry volumio[1033]: info: ControllerMpd::pushState oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::servicePushState oct. 11 12:42:36 chatbry volumio[1033]: info: CoreStateMachine::pushState oct. 11 12:42:36 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:36 chatbry volumio[1033]: info: CoreCommandRouter::volumioPushState oct. 11 12:42:36 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:36 chatbry volumio[1033]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd oct. 11 12:42:36 chatbry volumio[1033]: info: ------------------------------ 243ms oct. 11 12:42:37 chatbry volumio[1033]: info: MyVolumio Plan changed: premium oct. 11 12:42:37 chatbry volumio[1033]: info: [MyVolumio PluginManager] Subscribed plan changed to premium oct. 11 12:42:37 chatbry volumio[1033]: info: Removing browser output: myVolumio user plan is not superstar oct. 11 12:42:37 chatbry volumio[1033]: info: Removing audio output: oct. 11 12:42:37 chatbry volumio[1033]: info: MYVOLUMIO: Adding device oct. 11 12:42:37 chatbry volumio[1033]: info: MYVOLUMIO: Evaluating Server oct. 11 12:42:37 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetState oct. 11 12:42:37 chatbry volumio[1033]: info: CorePlayQueue::getTrack 0 oct. 11 12:42:37 chatbry volumio[1033]: info: Setting Geolocation for MyVolumio to eu10 oct. 11 12:42:37 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:37 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:37 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::volumioGetBrowseSources oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion oct. 11 12:42:38 chatbry volumio[1033]: info: Updating MyVolumio device info oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:38 chatbry volumio[1033]: info: Remote config written successfully oct. 11 12:42:38 chatbry volumio[1033]: info: Starting Tunnel 1 oct. 11 12:42:38 chatbry volumio[1033]: info: Starting Tunnel Connection Checker oct. 11 12:42:38 chatbry volumio[1033]: info: Completed starting MyVolumio Plugin oct. 11 12:42:38 chatbry volumio[1033]: info: Successfully Added MyVolumio device oct. 11 12:42:39 chatbry volumio[1033]: info: AutoStart - Check #4/20 - VOLUMIO_SYSTEM_STATUS = starting oct. 11 12:42:39 chatbry volumio[1033]: info: MYVolumio Device enabled oct. 11 12:42:39 chatbry volumio[1033]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... oct. 11 12:42:39 chatbry volumio[1033]: info: Setting Geolocation for MyVolumio to eu3 oct. 11 12:42:39 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:39 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:39 chatbry volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam oct. 11 12:42:39 chatbry volumio[1033]: [2026-10-11T10:42:39.160Z] @firebase/database: FIREBASE WARNING: Exception was thrown by user callback. TypeError: Cannot read properties of null (reading 'replace') oct. 11 12:42:39 chatbry volumio[1033]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) oct. 11 12:42:39 chatbry volumio[1033]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) oct. 11 12:42:39 chatbry volumio[1033]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) oct. 11 12:42:39 chatbry volumio[1033]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/v-conf/index.js:166:13 oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/multimap/index.js:140:9 oct. 11 12:42:39 chatbry volumio[1033]: at Array.forEach () oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/multimap/index.js:139:13 oct. 11 12:42:39 chatbry volumio[1033]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) oct. 11 12:42:39 chatbry volumio[1033]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:133:5) oct. 11 12:42:39 chatbry volumio[1033]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:138:10) oct. 11 12:42:39 chatbry volumio[1033]: at Config.set (/volumio/node_modules/v-conf/index.js:163:20) oct. 11 12:42:39 chatbry volumio[1033]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36229) oct. 11 12:42:39 chatbry volumio[1033]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17831 oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 oct. 11 12:42:39 chatbry volumio[1033]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) oct. 11 12:42:39 chatbry volumio[1033]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| oct. 11 12:42:39 chatbry volumio[1033]: TypeError: Cannot read properties of null (reading 'replace') oct. 11 12:42:39 chatbry volumio[1033]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) oct. 11 12:42:39 chatbry volumio[1033]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) oct. 11 12:42:39 chatbry volumio[1033]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) oct. 11 12:42:39 chatbry volumio[1033]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/v-conf/index.js:166:13 oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/multimap/index.js:140:9 oct. 11 12:42:39 chatbry volumio[1033]: at Array.forEach () oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/multimap/index.js:139:13 oct. 11 12:42:39 chatbry volumio[1033]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) oct. 11 12:42:39 chatbry volumio[1033]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:133:5) oct. 11 12:42:39 chatbry volumio[1033]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:138:10) oct. 11 12:42:39 chatbry volumio[1033]: at Config.set (/volumio/node_modules/v-conf/index.js:163:20) oct. 11 12:42:39 chatbry volumio[1033]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36229) oct. 11 12:42:39 chatbry volumio[1033]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17831 oct. 11 12:42:39 chatbry volumio[1033]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 oct. 11 12:42:39 chatbry volumio[1033]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) oct. 11 12:42:39 chatbry volumio[1033]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| oct. 11 12:42:40 chatbry kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s oct. 11 12:42:40 chatbry kernel: sd 0:0:0:0: [sda] tag#0 Sense Key : 0x3 [current] oct. 11 12:42:40 chatbry kernel: sd 0:0:0:0: [sda] tag#0 ASC=0x11 ASCQ=0x0 oct. 11 12:42:40 chatbry kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 37 c0 00 00 00 40 00 oct. 11 12:42:40 chatbry kernel: critical medium error, dev sda, sector 3653632 op 0x0:(READ) flags 0x80700 phys_seg 4 prio class 3 oct. 11 12:42:46 chatbry sudo[1786]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-11 12:41' oct. 11 12:42:46 chatbry sudo[1786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"