-- Logs begin at Fri 2025-05-30 08:53:14 UTC, end at Sun 2025-06-15 10:42:34 UTC. --
Jun 15 10:42:03 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 15 10:42:03 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 15 10:42:03 desk volumio[845]: info: Discovery: Getting this device information
Jun 15 10:42:03 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:03 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 15 10:42:03 desk volumio[845]: verbose: New Socket.io Connection to 192.168.86.144:3000 from 192.168.86.84 UA: Dart/3.5 (dart:io) Total Clients: 6
Jun 15 10:42:03 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:03 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 15 10:42:03 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 15 10:42:12 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:12 desk volumio[845]: verbose: New Socket.io Connection to 192.168.86.144:3000 from 192.168.86.84 UA: Dart/3.5 (dart:io) Total Clients: 7
Jun 15 10:42:12 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:12 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 15 10:42:12 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 15 10:42:12 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:13 desk sudo[32479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 15 10:42:13 desk sudo[32479]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 15 10:42:13 desk sudo[32479]: pam_unix(sudo:session): session closed for user root
Jun 15 10:42:13 desk sudo[32482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 15 10:42:13 desk sudo[32482]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 15 10:42:13 desk sudo[32482]: pam_unix(sudo:session): session closed for user root
Jun 15 10:42:13 desk volumio[845]: verbose: New Socket.io Connection to 192.168.86.144 from 192.168.86.84 UA: Mozilla/5.0 (Linux; Android 15; Pixel 9 Pro Build/BP1A.250505.005.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Total Clients: 8
Jun 15 10:42:14 desk sudo[32485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 15 10:42:14 desk sudo[32485]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 15 10:42:14 desk sudo[32485]: pam_unix(sudo:session): session closed for user root
Jun 15 10:42:14 desk sudo[32488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 15 10:42:14 desk sudo[32488]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 15 10:42:14 desk sudo[32488]: pam_unix(sudo:session): session closed for user root
Jun 15 10:42:14 desk volumio[845]: verbose: New Socket.io Connection to 192.168.86.144 from 192.168.86.84 UA: Mozilla/5.0 (Linux; Android 15; Pixel 9 Pro Build/BP1A.250505.005.A1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.61 Mobile Safari/537.36 Total Clients: 9
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 15 10:42:14 desk volumio[845]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jun 15 10:42:14 desk volumio[845]: info: Received Get System Info
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 15 10:42:14 desk volumio[845]: info: Discovery: Getting this device information
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:14 desk volumio[845]: info: Listing playlists
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 15 10:42:14 desk volumio[845]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read
Jun 15 10:42:14 desk kernel: SQUASHFS error: zlib decompression failed, data probably corrupt
Jun 15 10:42:14 desk kernel: SQUASHFS error: Failed to read block 0x1cc29317: -5
Jun 15 10:42:14 desk kernel: SQUASHFS error: Unable to read fragment cache entry [1cc29317]
Jun 15 10:42:14 desk kernel: SQUASHFS error: Unable to read fragment cache entry [1cc29317]
Jun 15 10:42:14 desk kernel: SQUASHFS error: Unable to read page, block 1cc29317, size ec0b
Jun 15 10:42:14 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 15 10:42:16 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 15 10:42:16 desk volumio[845]: info: Received Get System Info
Jun 15 10:42:16 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 15 10:42:16 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 15 10:42:16 desk volumio[845]: info: Discovery: Getting this device information
Jun 15 10:42:16 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:16 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 15 10:42:16 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 15 10:42:19 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 15 10:42:19 desk volumio[845]: info: Received Get System Info
Jun 15 10:42:19 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 15 10:42:19 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 15 10:42:19 desk volumio[845]: info: Discovery: Getting this device information
Jun 15 10:42:19 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:19 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 15 10:42:20 desk volumio[845]: info: Retrieving Cloud Streaming UI
Jun 15 10:42:20 desk volumio[845]: info: Getting Tidal Cloud Configuration
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 15 10:42:20 desk volumio[845]: info: Getting Qobuz Cloud Configuration
Jun 15 10:42:20 desk volumio[845]: info: Asking plugin for UI Config
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 15 10:42:20 desk volumio[845]: info: Getting Spotify Cloud Configuration
Jun 15 10:42:20 desk volumio[845]: info: Asking plugin for UI Config
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 15 10:42:20 desk volumio[845]: info: Saving Spotify Acccount
Jun 15 10:42:20 desk volumio[845]: info: Got it
Jun 15 10:42:20 desk volumio[845]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jun 15 10:42:20 desk volumio[845]: info: Got Tidal Cloud Configuration
Jun 15 10:42:20 desk volumio[845]: info: Got it
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 15 10:42:20 desk volumio[845]: error: MPD error: The expression evaluated to a falsy value:
Jun 15 10:42:20 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:20 desk volumio[845]: error: The expression evaluated to a falsy value:
Jun 15 10:42:20 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:20 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jun 15 10:42:21 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 15 10:42:21 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 15 10:42:21 desk volumio[845]: info: Discovery: Getting this device information
Jun 15 10:42:21 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:21 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 15 10:42:24 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 15 10:42:24 desk volumio[845]: error: MPD error: The expression evaluated to a falsy value:
Jun 15 10:42:24 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:24 desk volumio[845]: error: The expression evaluated to a falsy value:
Jun 15 10:42:24 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:25 desk volumio[845]: info: Disabling MyMusic plugin upnp
Jun 15 10:42:25 desk sudo[32494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Jun 15 10:42:25 desk sudo[32494]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 15 10:42:25 desk systemd[1]: Stopping UPnP Renderer front-end to MPD...
Jun 15 10:42:25 desk systemd[1]: upmpdcli.service: Main process exited, code=killed, status=15/TERM
Jun 15 10:42:25 desk systemd[1]: upmpdcli.service: Succeeded.
Jun 15 10:42:25 desk systemd[1]: Stopped UPnP Renderer front-end to MPD.
Jun 15 10:42:25 desk volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jun 15 10:42:25 desk sudo[32494]: pam_unix(sudo:session): session closed for user root
Jun 15 10:42:25 desk volumio[845]: info: Disabling plugin upnp
Jun 15 10:42:25 desk volumio[845]: info: Done.
Jun 15 10:42:27 desk volumio[845]: info: Enabling MyMusic plugin upnp
Jun 15 10:42:27 desk volumio[845]: info: Enabling plugin upnp
Jun 15 10:42:27 desk volumio[845]: info: Loading plugin "upnp"...
Jun 15 10:42:27 desk volumio[845]: info: [1749984147435] Starting Upmpd Daemon
Jun 15 10:42:27 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 15 10:42:27 desk volumio[845]: info: Done.
Jun 15 10:42:28 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 15 10:42:28 desk volumio[845]: error: MPD error: The expression evaluated to a falsy value:
Jun 15 10:42:28 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:28 desk volumio[845]: error: The expression evaluated to a falsy value:
Jun 15 10:42:28 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:29 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Jun 15 10:42:29 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Jun 15 10:42:31 desk volumio[845]: info: Error browsing device Andy’s Mac mini (2) for shares : Error: Command failed: echo volumio | smbclient -L Andys-Mac-mini-3.local.
Jun 15 10:42:31 desk volumio[845]: Unable to initialize messaging context
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 15 10:42:32 desk volumio[845]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jun 15 10:42:32 desk volumio[845]: info: Received Get System Version
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 15 10:42:32 desk volumio[845]: info: Received Get System Info
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 15 10:42:32 desk volumio[845]: info: Discovery: Getting this device information
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::volumioGetState
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 15 10:42:32 desk volumio[845]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 15 10:42:32 desk volumio[845]: error: MPD error: The expression evaluated to a falsy value:
Jun 15 10:42:32 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:32 desk volumio[845]: error: The expression evaluated to a falsy value:
Jun 15 10:42:32 desk volumio[845]: assert.ok(self.idling)
Jun 15 10:42:34 desk volumio[845]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 15 10:42:34 desk volumio[845]: Error: dns service error: unknown
Jun 15 10:42:34 desk volumio[845]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30)
Jun 15 10:42:34 desk volumio[845]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Jun 15 10:42:34 desk volumio[845]: errorCode: -65537
Jun 15 10:42:34 desk volumio[845]: }
Jun 15 10:42:34 desk volumio[845]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 15 10:42:34 desk sudo[32513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-15 10:41
Jun 15 10:42:34 desk sudo[32513]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="f8baf7ad070f376535a93fcc6590774528ddb153"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET"
VOLUMIO_VERSION="3.611"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"