Oct 12 19:37:00 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 19:37:00 volumio volumio[1368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Oct 12 19:37:00 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:00 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:01 volumio sudo[1949]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Lenovo,password=89506496140tEl,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.106/Downloads /mnt/NAS/ThinkPad
Oct 12 19:37:01 volumio sudo[1949]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 12 19:37:01 volumio kernel: CIFS: Attempting to mount //192.168.0.106/Downloads
Oct 12 19:37:03 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 19:37:03 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 19:37:03 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 12 19:37:04 volumio volumio-remote-updater[1020]: Test mode disabled
Oct 12 19:37:04 volumio volumio-remote-updater[1020]: Alpha mode disabled
Oct 12 19:37:04 volumio volumio-remote-updater[1020]: Alpha legacy test mode disabled
Oct 12 19:37:04 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 12 19:37:04 volumio volumio[1368]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Oct 12 19:37:04 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 19:37:05 volumio upmpdcli[1971]: writing RSA key
Oct 12 19:37:05 volumio volumio[1368]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Oct 12 19:37:05 volumio volumio[1368]: info: Completed starting MyVolumio Plugin
Oct 12 19:37:05 volumio volumio[1368]: [Metrics] CommandRouter: 33s 177.40ms
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::Close All Modals sent
Oct 12 19:37:05 volumio volumio[1368]: info: CoreCommandRouter::Close All Modals sent
Oct 12 19:37:05 volumio volumio[1368]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT
Oct 12 19:37:06 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 12 19:37:06 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 12 19:37:06 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 12 19:37:07 volumio sudo[1949]: pam_unix(sudo:session): session closed for user root
Oct 12 19:37:07 volumio volumio[1368]: info: Cannot mount NAS ThinkPad at system boot, trial number 4 ,retrying in 5 seconds
Oct 12 19:37:07 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Oct 12 19:37:07 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Oct 12 19:37:12 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:12.027+05:00 level=ERROR msg="failed to notify all device data" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.101:65525 @ 0x1400de0" latency=4.401444ms timeout=20s error="failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded"
Oct 12 19:37:12 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 12 19:37:12 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 12 19:37:12 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 12 19:37:12 volumio volumio[1368]: info: BOOT COMPLETED
Oct 12 19:37:12 volumio sudo[1980]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Lenovo,password=89506496140tEl,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.106/Downloads /mnt/NAS/ThinkPad
Oct 12 19:37:12 volumio sudo[1980]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 12 19:37:12 volumio kernel: CIFS: Attempting to mount //192.168.0.106/Downloads
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.448+05:00 level=ERROR msg="failed to notify all device data" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.101:65525 @ 0x1400de0" latency=5.918155ms timeout=20s error="failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded"
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.497+05:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.101:65525 @ 0x1400de0" latency=11.195264ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.510+05:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.686+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=175.607541ms
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.708+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://functions.volumio.cloud duration=196.740195ms
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.715+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://functions.volumio.cloud duration=203.63058ms
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.780+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://www.googleapis.com duration=269.855365ms
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.820+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=http://pushupdates.volumio.org duration=308.445814ms
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.849+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://securetoken.googleapis.com duration=338.410847ms
Oct 12 19:37:14 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:14.880+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=369.230395ms
Oct 12 19:37:15 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:15.025+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://database.volumio.cloud duration=514.141406ms
Oct 12 19:37:15 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:15.106+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=595.32155ms
Oct 12 19:37:15 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:15.144+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=633.843406ms
Oct 12 19:37:15 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:15.475+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=https://google.com duration=965.013053ms
Oct 12 19:37:15 volumio sudo[2006]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 12 19:37:15 volumio sudo[2006]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 12 19:37:15 volumio sudo[2008]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 12 19:37:15 volumio sudo[2008]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 12 19:37:15 volumio sudo[2006]: pam_unix(sudo:session): session closed for user root
Oct 12 19:37:15 volumio sudo[2008]: pam_unix(sudo:session): session closed for user root
Oct 12 19:37:15 volumio volumio[1368]: verbose: New Socket.io Connection to 192.168.0.103 from 192.168.0.101 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 5
Oct 12 19:37:15 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:15.667+05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=http://plugins.volumio.org duration=1.155941416s
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:15 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 12 19:37:15 volumio volumio[1368]: info: Received Get System Info
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 19:37:15 volumio volumio[1368]: info: Discovery: Getting this device information
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:15 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:15 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:15 volumio volumio[1368]: info: Listing playlists
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 19:37:15 volumio sudo[2012]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 12 19:37:15 volumio sudo[2012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 12 19:37:15 volumio sudo[2014]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 12 19:37:15 volumio sudo[2012]: pam_unix(sudo:session): session closed for user root
Oct 12 19:37:15 volumio sudo[2014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 12 19:37:15 volumio sudo[2014]: pam_unix(sudo:session): session closed for user root
Oct 12 19:37:15 volumio volumio[1368]: verbose: New Socket.io Connection to 192.168.0.103 from 192.168.0.101 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 6
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:15 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetQueue
Oct 12 19:37:15 volumio volumio[1368]: info: CoreStateMachine::getQueue
Oct 12 19:37:15 volumio volumio[1368]: info: CorePlayQueue::getQueue
Oct 12 19:37:15 volumio volumio[1368]: info: Listing playlists
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 12 19:37:15 volumio volumio[1368]: info: Received Get System Info
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 19:37:15 volumio volumio[1368]: info: Discovery: Getting this device information
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:15 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:15 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 12 19:37:15 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 12 19:37:15 volumio volumio5-onboarding[1552]: time=2026-10-12T19:37:15.993+05:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.0.101:65525 @ 0x1400de0" latency=10.691639ms timeout=10s endpoint=http://cddb.volumio.org duration=1.4819826s error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF"
Oct 12 19:37:16 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems...
Oct 12 19:37:16 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Oct 12 19:37:16 volumio systemd[1]: e2scrub_all.service: Deactivated successfully.
Oct 12 19:37:16 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems.
Oct 12 19:37:17 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Oct 12 19:37:17 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Oct 12 19:37:17 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 12 19:37:17 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 12 19:37:17 volumio volumio[1368]: info: Received Get System Info
Oct 12 19:37:17 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 19:37:17 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 19:37:17 volumio volumio[1368]: info: Discovery: Getting this device information
Oct 12 19:37:17 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:17 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:17 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 19:37:18 volumio sudo[1980]: pam_unix(sudo:session): session closed for user root
Oct 12 19:37:18 volumio volumio[1368]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 12 19:37:18 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Oct 12 19:37:18 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Oct 12 19:37:19 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 12 19:37:19 volumio volumio[1368]: info: Received Get System Info
Oct 12 19:37:19 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 19:37:19 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 19:37:19 volumio volumio[1368]: info: Discovery: Getting this device information
Oct 12 19:37:19 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:19 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:19 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 19:37:22 volumio volumio[1368]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT
Oct 12 19:37:25 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 12 19:37:34 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 19:37:34 volumio volumio[1368]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 12 19:37:34 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 12 19:37:34 volumio volumio[1368]: info: Received Get System Version
Oct 12 19:37:34 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 19:37:34 volumio volumio[1368]: info: Received Get System Info
Oct 12 19:37:34 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 19:37:34 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 19:37:34 volumio volumio[1368]: info: Discovery: Getting this device information
Oct 12 19:37:34 volumio volumio[1368]: info: CoreCommandRouter::volumioGetState
Oct 12 19:37:34 volumio volumio[1368]: info: CorePlayQueue::getTrack 0
Oct 12 19:37:34 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 19:37:43 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 12 19:37:43 volumio volumio[1368]: info: CURURI: music-library
Oct 12 19:37:43 volumio volumio[1368]: info: Preload queue cleared
Oct 12 19:37:49 volumio volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 12 19:37:49 volumio volumio[1368]: info: CURURI: music-library/INTERNAL
Oct 12 19:37:49 volumio volumio[1368]: info: Preload queue cleared
Oct 12 19:38:14 volumio volumio[1368]: info: Preload queue cleared
Oct 12 19:38:14 volumio volumio[1368]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 12 19:38:14 volumio volumio[1368]: info: CoreStateMachine::ClearQueue
Oct 12 19:38:14 volumio volumio[1368]: info: CoreStateMachine::stop
Oct 12 19:38:14 volumio volumio[1368]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 19:38:14 volumio volumio[1368]: info: CorePlayQueue::clearPlayQueue
Oct 12 19:38:14 volumio volumio[1368]: info: CorePlayQueue::saveQueue
Oct 12 19:38:14 volumio volumio[1368]: info: CoreCommandRouter::volumioPushQueue
Oct 12 19:38:14 volumio volumio[1368]: info: CoreStateMachine::addQueueItems
Oct 12 19:38:14 volumio volumio[1368]: info: CorePlayQueue::addQueueItems
Oct 12 19:38:14 volumio volumio[1368]: info: Preload queue cleared
Oct 12 19:38:14 volumio volumio[1368]: info: Adding Item to queue: music-library/INTERNAL/Pink Floyd 1973 The Dark Side Of The Moon [1st Japan]
Oct 12 19:38:14 volumio volumio[1368]: info: Exploding uri music-library/INTERNAL/Pink Floyd 1973 The Dark Side Of The Moon [1st Japan] in service mpd
Oct 12 19:38:14 volumio volumio[1368]: info: ALBUMART /albumart?cacheid=65&web=Pink%20Floyd/Dark%20Side%20of%20the%20Moon.CP35-3017.Japan/extralarge&path=%2Fmnt%2FINTERNAL%2FPink%20Floyd%201973%20The%20Dark%20Side%20Of%20The%20Moon%20%5B1st%20Japan%5D%2FPink%20Floyd%20-%20Dark%20Side%20of%20the%20Moon.CP35-3017.Japan.Flags%20Pre.cue&metadata=false
Oct 12 19:38:14 volumio volumio[1368]: info: URI /mnt/INTERNAL/Pink Floyd 1973 The Dark Side Of The Moon [1st Japan]/Pink Floyd - Dark Side of the Moon.CP35-3017.Japan.Flags Pre.cue
Oct 12 19:38:14 volumio volumio[1368]: info: ALBUMART /albumart?cacheid=65&web=Pink%20Floyd/Dark%20Side%20of%20the%20Moon.CP35-3017.Japan/extralarge&path=%2Fmnt%2FINTERNAL%2FPink%20Floyd%201973%20The%20Dark%20Side%20Of%20The%20Moon%20%5B1st%20Japan%5D%2FPink%20Floyd%20-%20Dark%20Side%20of%20the%20Moon.CP35-3017.Japan.Flags%20Pre.cue&metadata=false
Oct 12 19:38:14 volumio volumio[1368]: info: URI /mnt/INTERNAL/Pink Floyd 1973 The Dark Side Of The Moon [1st Japan]/Pink Floyd - Dark Side of the Moon.CP35-3017.Japan.Flags Pre.cue
Oct 12 19:38:14 volumio volumio[1368]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 12 19:38:14 volumio volumio[1368]: Error: Unable to resolve or reject the same promise twice
Oct 12 19:38:14 volumio volumio[1368]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Oct 12 19:38:14 volumio volumio[1368]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21
Oct 12 19:38:14 volumio volumio[1368]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Oct 12 19:38:14 volumio volumio[1368]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Oct 12 19:38:14 volumio volumio[1368]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Oct 12 19:38:14 volumio volumio[1368]: at Socket.emit (node:events:514:28)
Oct 12 19:38:14 volumio volumio[1368]: at addChunk (node:internal/streams/readable:343:12)
Oct 12 19:38:14 volumio volumio[1368]: at readableAddChunk (node:internal/streams/readable:312:11)
Oct 12 19:38:14 volumio volumio[1368]: at Readable.push (node:internal/streams/readable:253:10)
Oct 12 19:38:14 volumio volumio[1368]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Oct 12 19:38:14 volumio volumio[1368]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 12 19:38:14 volumio sudo[2151]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 19:37'
Oct 12 19:38:14 volumio sudo[2151]: 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"