Apr 11 21:35:02 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:02 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:07 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:07 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:12 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:12 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:17 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:17 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:22 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:22 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:27 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:27 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:32 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:32 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:37 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:37 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:39 volumio kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd
Apr 11 21:35:39 volumio kernel: usb 1-1.1: New USB device found, idVendor=048d, idProduct=1234, bcdDevice= 2.00
Apr 11 21:35:39 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Apr 11 21:35:39 volumio kernel: usb 1-1.1: Product: Disk 2.0
Apr 11 21:35:39 volumio kernel: usb 1-1.1: Manufacturer: USB
Apr 11 21:35:39 volumio kernel: usb 1-1.1: SerialNumber: 0643701142601225414
Apr 11 21:35:39 volumio kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected
Apr 11 21:35:39 volumio kernel: scsi host0: usb-storage 1-1.1:1.0
Apr 11 21:35:40 volumio kernel: scsi 0:0:0:0: Direct-Access VendorCo ProductCode 2.00 PQ: 0 ANSI: 4
Apr 11 21:35:40 volumio kernel: sd 0:0:0:0: [sda] 4096000000 512-byte logical blocks: (2.10 TB/1.91 TiB)
Apr 11 21:35:40 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off
Apr 11 21:35:40 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 03 00 00 00
Apr 11 21:35:40 volumio kernel: sd 0:0:0:0: [sda] No Caching mode page found
Apr 11 21:35:40 volumio kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through
Apr 11 21:35:40 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Apr 11 21:35:40 volumio kernel: sda: sda1
Apr 11 21:35:40 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Apr 11 21:35:41 volumio volumio[1376]: info: Mounting Device 76E8-CACF
Apr 11 21:35:41 volumio sudo[17514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/76E8-CACF -o noatime
Apr 11 21:35:41 volumio sudo[17514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 21:35:41 volumio kernel: exFAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Apr 11 21:35:42 volumio sudo[17514]: pam_unix(sudo:session): session closed for user root
Apr 11 21:35:42 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:42 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:42 volumio volumio[1376]: info: Scanning new location : "USB/76E8-CACF"
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:35:42 volumio volumio[1376]: info:
Apr 11 21:35:42 volumio volumio[1376]: ---------------------------- MPD announces state update: update
Apr 11 21:35:42 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:35:42 volumio volumio[1376]: info:
Apr 11 21:35:42 volumio volumio[1376]: ---------------------------- MPD announces state update: update
Apr 11 21:35:42 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:35:42 volumio volumio[1376]: info:
Apr 11 21:35:42 volumio volumio[1376]: ---------------------------- MPD announces state update: update
Apr 11 21:35:42 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand status took 9 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand status took 8 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:35:42 volumio volumio[1376]: info: Command Router : Notfying DB Updatetrue
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand status took 96 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand status took 96 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand status took 96 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand status took 95 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:35:42 volumio volumio[1376]: info: Command Router : Notfying DB Updatetrue
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::Close All Modals sent
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:35:42 volumio volumio[1376]: info: Command Router : Notfying DB Updatetrue
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::Close All Modals sent
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 82 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 39 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:35:42 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:35:42 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:35:42 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:35:42 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:35:42 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:35:42 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:35:42 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:35:42 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:35:42 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:35:42 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:35:42 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:35:42 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:35:42 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:35:42 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:35:42 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:35:42 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:35:42 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:35:43 volumio volumio[1376]: info: ------------------------------ 210ms
Apr 11 21:35:43 volumio volumio[1376]: info: ------------------------------ 203ms
Apr 11 21:35:43 volumio volumio[1376]: info: ------------------------------ 204ms
Apr 11 21:35:47 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:47 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:52 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:52 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:35:57 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:35:57 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:01 volumio volumio[1376]: verbose: New Socket.io Connection to 192.168.31.238 from 192.168.31.167 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::volumioGetState
Apr 11 21:36:02 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 11 21:36:02 volumio volumio[1376]: info: Received Get System Info
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 21:36:02 volumio volumio[1376]: info: Discovery: Getting this device information
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::volumioGetState
Apr 11 21:36:02 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::volumioGetState
Apr 11 21:36:02 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:02 volumio volumio[1376]: info: Listing playlists
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::volumioGetQueue
Apr 11 21:36:02 volumio volumio[1376]: info: CoreStateMachine::getQueue
Apr 11 21:36:02 volumio volumio[1376]: info: CorePlayQueue::getQueue
Apr 11 21:36:02 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 11 21:36:02 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:02 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:04 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 11 21:36:04 volumio volumio[1376]: info: Received Get System Info
Apr 11 21:36:04 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 21:36:04 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 21:36:04 volumio volumio[1376]: info: Discovery: Getting this device information
Apr 11 21:36:04 volumio volumio[1376]: info: CoreCommandRouter::volumioGetState
Apr 11 21:36:04 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:04 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 21:36:07 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:07 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:12 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:12 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:15 volumio volumio[1376]: info: MPD Database updated - AlbumList cache refreshed
Apr 11 21:36:15 volumio volumio[1376]: info:
Apr 11 21:36:15 volumio volumio[1376]: ---------------------------- MPD announces state update: database
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info:
Apr 11 21:36:15 volumio volumio[1376]: ---------------------------- MPD announces state update: update
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info: MPD Database updated - AlbumList cache refreshed
Apr 11 21:36:15 volumio volumio[1376]: info:
Apr 11 21:36:15 volumio volumio[1376]: ---------------------------- MPD announces state update: database
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info:
Apr 11 21:36:15 volumio volumio[1376]: ---------------------------- MPD announces state update: update
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info: MPD Database updated - AlbumList cache refreshed
Apr 11 21:36:15 volumio volumio[1376]: info:
Apr 11 21:36:15 volumio volumio[1376]: ---------------------------- MPD announces state update: database
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info:
Apr 11 21:36:15 volumio volumio[1376]: ---------------------------- MPD announces state update: update
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::getState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 64 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 64 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 64 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: info: Command Router : Notfying DB Updatefalse
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::Close All Modals sent
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 150 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 151 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 151 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: info: Command Router : Notfying DB Updatefalse
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::Close All Modals sent
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 204 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 203 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand status took 203 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 88 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 84 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: info: Command Router : Notfying DB Updatefalse
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::Close All Modals sent
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseState
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:36:15 volumio volumio[1376]: info: ------------------------------ 247ms
Apr 11 21:36:15 volumio volumio[1376]: info: ------------------------------ 247ms
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 69 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 69 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:36:15 volumio volumio[1376]: verbose: ControllerMpd::parseTrackInfo
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:36:15 volumio volumio[1376]: info: ControllerMpd::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::servicePushState
Apr 11 21:36:15 volumio volumio[1376]: info: CoreStateMachine::pushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: CoreCommandRouter::volumioPushState
Apr 11 21:36:15 volumio volumio[1376]: info: CorePlayQueue::getTrack 0
Apr 11 21:36:15 volumio volumio[1376]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 11 21:36:15 volumio volumio[1376]: info: ------------------------------ 265ms
Apr 11 21:36:15 volumio volumio[1376]: info: ------------------------------ 265ms
Apr 11 21:36:15 volumio volumio[1376]: info: ------------------------------ 265ms
Apr 11 21:36:15 volumio volumio[1376]: info: ------------------------------ 265ms
Apr 11 21:36:17 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:17 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:22 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:22 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:27 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:27 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:32 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:32 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:37 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:37 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:42 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:42 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:47 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:47 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:52 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:52 volumio volumio[1376]: info: Discovery: Restarting Browsing
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 21:36:53 volumio volumio[1376]: info: Retrieving Cloud Streaming UI
Apr 11 21:36:53 volumio volumio[1376]: info: Getting Tidal Cloud Configuration
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 21:36:53 volumio volumio[1376]: info: Getting Qobuz Cloud Configuration
Apr 11 21:36:53 volumio volumio[1376]: info: Asking plugin for UI Config
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 21:36:53 volumio volumio[1376]: info: Getting Spotify Cloud Configuration
Apr 11 21:36:53 volumio volumio[1376]: info: Asking plugin for UI Config
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 21:36:53 volumio volumio[1376]: info: Saving Spotify Acccount
Apr 11 21:36:53 volumio volumio[1376]: info: Got Tidal Cloud Configuration
Apr 11 21:36:53 volumio volumio[1376]: info: Got it
Apr 11 21:36:53 volumio volumio[1376]: info: Got it
Apr 11 21:36:53 volumio volumio[1376]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 21:36:53 volumio volumio[1376]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 11 21:36:53 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 11 21:36:55 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Apr 11 21:36:55 volumio volumio[1376]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Apr 11 21:36:55 volumio dbus-daemon[760]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256)
Apr 11 21:36:55 volumio volumio[1376]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 21:36:55 volumio volumio[1376]: Error: dns service error: refused
Apr 11 21:36:55 volumio volumio[1376]: at new Browser (/volumio/node_modules/mdns/lib/browser.js:88:10)
Apr 11 21:36:55 volumio volumio[1376]: at Object.create [as createBrowser] (/volumio/node_modules/mdns/lib/browser.js:116:10)
Apr 11 21:36:55 volumio volumio[1376]: at ControllerVolumioDiscovery.browseForService (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:718:32)
Apr 11 21:36:55 volumio volumio[1376]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32)
Apr 11 21:36:55 volumio volumio[1376]: at ControllerNetworkfs.discoverShares (/volumio/app/plugins/system_controller/networkfs/index.js:826:36)
Apr 11 21:36:55 volumio volumio[1376]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32)
Apr 11 21:36:55 volumio volumio[1376]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1614:45)
Apr 11 21:36:55 volumio volumio[1376]: at Socket.emit (node:events:514:28)
Apr 11 21:36:55 volumio volumio[1376]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 11 21:36:55 volumio volumio[1376]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) {
Apr 11 21:36:55 volumio volumio[1376]: errorCode: -65553
Apr 11 21:36:55 volumio volumio[1376]: }
Apr 11 21:36:55 volumio volumio[1376]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 21:36:55 volumio sudo[17681]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-11 21:35'
Apr 11 21:36:55 volumio sudo[17681]: 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"
VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"