Aug 31 10:49:04 volumiosoldo4 volumio[1145]: Searching all installed plugins
Aug 31 10:49:04 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 31 10:49:04 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: , search
Aug 31 10:49:04 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Aug 31 10:49:04 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search
Aug 31 10:49:04 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: last_100 , search
Aug 31 10:49:04 volumiosoldo4 volumio[1145]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100
Aug 31 10:49:04 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Aug 31 10:49:06 volumiosoldo4 volumio[1145]: info: All search sources collected, pushing search results
Aug 31 10:49:16 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 31 10:49:16 volumiosoldo4 volumio[1145]: info: CURURI: artists://Steven%20Wilson%3B%20Ninet%20Tayeb
Aug 31 10:49:16 volumiosoldo4 volumio[1145]: error: Parse List Albums error:null
Aug 31 10:49:16 volumiosoldo4 volumio[1145]: error: Failed to execute browseSource: Error
Aug 31 10:49:20 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 31 10:49:20 volumiosoldo4 volumio[1145]: info: CURURI: albums://Steven%20Wilson/To%20The%20Bone
Aug 31 10:49:20 volumiosoldo4 volumio[1145]: info: Preload queue cleared
Aug 31 10:49:20 volumiosoldo4 volumio[1145]: info: No valid Plugin REST Endpoint
Aug 31 10:49:24 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:24.898+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=88.523372ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE
Aug 31 10:49:24 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:24.915+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.027+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=111.527996ms
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.066+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=http://pushupdates.volumio.org duration=136.998081ms
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.217+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://www.googleapis.com duration=301.704359ms
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.254+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://securetoken.googleapis.com duration=334.589823ms
Aug 31 10:49:25 volumiosoldo4 sudo[16216]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 31 10:49:25 volumiosoldo4 sudo[16216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 31 10:49:25 volumiosoldo4 sudo[16216]: pam_unix(sudo:session): session closed for user root
Aug 31 10:49:25 volumiosoldo4 sudo[16218]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 31 10:49:25 volumiosoldo4 sudo[16218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 31 10:49:25 volumiosoldo4 sudo[16218]: pam_unix(sudo:session): session closed for user root
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.313+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=388.953984ms
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: verbose: New Socket.io Connection to 192.168.188.175 from 192.168.188.131 UA: Mozilla/5.0 (Linux; Android 16; SM-S911B Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.401+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://functions.volumio.cloud duration=475.237ms
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.413+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://functions.volumio.cloud duration=497.387309ms
Aug 31 10:49:25 volumiosoldo4 sudo[16223]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 31 10:49:25 volumiosoldo4 sudo[16223]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 31 10:49:25 volumiosoldo4 sudo[16224]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 31 10:49:25 volumiosoldo4 sudo[16224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.487+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=http://cddb.volumio.org duration=566.785147ms
Aug 31 10:49:25 volumiosoldo4 sudo[16223]: pam_unix(sudo:session): session closed for user root
Aug 31 10:49:25 volumiosoldo4 sudo[16224]: pam_unix(sudo:session): session closed for user root
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.509+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://google.com duration=593.730379ms
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: verbose: New Socket.io Connection to 192.168.188.175 from 192.168.188.131 UA: Mozilla/5.0 (Linux; Android 16; SM-S911B Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.523+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://database.volumio.cloud duration=603.712779ms
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.635+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=715.936189ms
Aug 31 10:49:25 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:25.636+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=708.105863ms
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetState
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CorePlayQueue::getTrack 0
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetQueue
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreStateMachine::getQueue
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CorePlayQueue::getQueue
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: Listing playlists
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: Received Get System Info
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: Discovery: Getting this device information
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetState
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CorePlayQueue::getTrack 0
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetState
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CorePlayQueue::getTrack 0
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 31 10:49:25 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 31 10:49:26 volumiosoldo4 volumio5-onboarding[1642]: time=2026-08-31T10:49:26.010+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44454,00:00:00:00:00:00%03 @ 0x1b0e210" latency=50.69688ms timeout=10s endpoint=http://plugins.volumio.org duration=1.087408175s
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: Received Get System Info
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: Discovery: Getting this device information
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetState
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: CorePlayQueue::getTrack 0
Aug 31 10:49:27 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: Received Get System Info
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: Discovery: Getting this device information
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetState
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: CorePlayQueue::getTrack 0
Aug 31 10:49:28 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 31 10:49:35 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Aug 31 10:49:36 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 31 10:49:36 volumiosoldo4 volumio[1145]: info: CURURI: artists://
Aug 31 10:49:36 volumiosoldo4 volumio[1145]: info: Preload queue cleared
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: Received Get System Version
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: Received Get System Info
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: Discovery: Getting this device information
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::volumioGetState
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CorePlayQueue::getTrack 0
Aug 31 10:49:43 volumiosoldo4 volumio[1145]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: TypeError: Cannot read properties of null (reading 'slice')
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at Object.onceWrapper (node:events:629:26)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at ClientRequest.emit (node:events:514:28)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at TLSSocket.socketOnData (node:_http_client:535:22)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at TLSSocket.emit (node:events:514:28)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at addChunk (node:internal/streams/readable:343:12)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at readableAddChunk (node:internal/streams/readable:316:9)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at Readable.push (node:internal/streams/readable:253:10)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23)
Aug 31 10:50:28 volumiosoldo4 volumio[1145]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 31 10:50:29 volumiosoldo4 sudo[16351]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-31 10:49'
Aug 31 10:50:29 volumiosoldo4 sudo[16351]: 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"