-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2026-02-22 13:05:13 CET. -- Feb 22 13:04:10 volumiopi5 volumio[917]: Searching all installed plugins Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: , search Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Feb 22 13:04:10 volumiopi5 volumio[917]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Feb 22 13:04:10 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: tidal , search Feb 22 13:04:10 volumiopi5 volumio[917]: info: searchTIDALUri took 350 milliseconds Feb 22 13:04:10 volumiopi5 volumio[917]: info: search took 350 milliseconds Feb 22 13:04:11 volumiopi5 volumio[917]: info: All search sources collected, pushing search results Feb 22 13:04:12 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:12 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:12 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:12 volumiopi5 volumio[917]: Searching all installed plugins Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: , search Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Feb 22 13:04:12 volumiopi5 volumio[917]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Feb 22 13:04:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: tidal , search Feb 22 13:04:13 volumiopi5 volumio[917]: info: Une erreur s'est produite lors de l'accès à SHOUTCAST Feb 22 13:04:13 volumiopi5 volumio[917]: info: searchTIDALUri took 520 milliseconds Feb 22 13:04:13 volumiopi5 volumio[917]: info: search took 520 milliseconds Feb 22 13:04:13 volumiopi5 volumio[917]: info: All search sources collected, pushing search results Feb 22 13:04:14 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:14 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:15 volumiopi5 volumio[917]: Searching all installed plugins Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: , search Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Feb 22 13:04:15 volumiopi5 volumio[917]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Feb 22 13:04:15 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: tidal , search Feb 22 13:04:15 volumiopi5 volumio[917]: info: Une erreur s'est produite lors de l'accès à SHOUTCAST Feb 22 13:04:15 volumiopi5 volumio[917]: info: searchTIDALUri took 381 milliseconds Feb 22 13:04:15 volumiopi5 volumio[917]: info: search took 382 milliseconds Feb 22 13:04:15 volumiopi5 volumio[917]: info: All search sources collected, pushing search results Feb 22 13:04:15 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:16 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:17 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:25 volumiopi5 volumio[917]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Feb 22 13:04:45 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:45.574+01:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.1.110:53432 error="websocket: close 1006 (abnormal closure): unexpected EOF" Feb 22 13:04:45 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:45.574+01:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.110:53432 Feb 22 13:04:45 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:45.574+01:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.110:53432 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.344+01:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.110:54922 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.394+01:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.110:54922 @ 0x1c50210" latency=873.162962ms platform=PLATFORM_ANDROID version=5.260120.0 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.396+01:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.110:54922 @ 0x1c50210" latency=872.615847ms timeout=10s Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.396+01:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" Feb 22 13:04:55 volumiopi5 volumio[917]: info: Received Get System Info Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 13:04:55 volumiopi5 volumio[917]: info: Discovery: Getting this device information Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::volumioGetState Feb 22 13:04:55 volumiopi5 volumio[917]: info: CorePlayQueue::getTrack 0 Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.401+01:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" name=VolumioPi5 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.402+01:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" language=fr Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.403+01:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" timezone=Europe/Paris Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.403+01:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" available=true connected=true macAddress=2c:cf:67:0a:1e:24 ip4Address=192.168.1.121/24 ip6Address= Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.404+01:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.404+01:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" setupComplete=true Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 22 13:04:55 volumiopi5 volumio[917]: amixer -c 0 info | grep "vc4-hdmi-0" Feb 22 13:04:55 volumiopi5 volumio[917]: Card hw:0 'vc4hdmi0'/'vc4-hdmi-0' Feb 22 13:04:55 volumiopi5 volumio[917]: amixer -c 1 info | grep "vc4-hdmi-1" Feb 22 13:04:55 volumiopi5 volumio[917]: Card hw:1 'vc4hdmi1'/'vc4-hdmi-1' Feb 22 13:04:55 volumiopi5 volumio[917]: amixer -c 5 info | grep "xCORE USB Audio 2.0" Feb 22 13:04:55 volumiopi5 volumio[917]: Card hw:5 'x20'/'XMOS xCORE USB Audio 2.0 at usb-xhci-hcd.1-2, high speed' Feb 22 13:04:55 volumiopi5 volumio[917]: amixer -c 5 info | grep "xCORE USB Audio 2.0" Feb 22 13:04:55 volumiopi5 volumio[917]: Card hw:5 'x20'/'XMOS xCORE USB Audio 2.0 at usb-xhci-hcd.1-2, high speed' Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.567+01:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" selectedOutputId=5 Feb 22 13:04:55 volumiopi5 volumio[917]: info: Received Get System Info Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 13:04:55 volumiopi5 volumio[917]: info: Discovery: Getting this device information Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::volumioGetState Feb 22 13:04:55 volumiopi5 volumio[917]: info: CorePlayQueue::getTrack 0 Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.582+01:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" currentVersion=3.908 latestVersion=3.908 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.582+01:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.110:54922 @ 0x1c50210" status=UPDATE_STATUS_NONE progress=0 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.582+01:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" userId=XrIbcNAOnFWLYFjRXmChQWxVX682 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.582+01:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" providers=9 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.582+01:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" plugins=54 Feb 22 13:04:55 volumiopi5 volumio[917]: info: CoreCommandRouter::volumioGetState Feb 22 13:04:55 volumiopi5 volumio[917]: info: CorePlayQueue::getTrack 0 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.585+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" state=STATUS_STOPPED positionMs=0 volume=100 Feb 22 13:04:55 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:55.585+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.110:54922 @ 0x1c50210" id= title= Feb 22 13:04:57 volumiopi5 volumio5-onboarding[1172]: time=2026-02-22T13:04:57.326+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.110:54922 @ 0x1c50210" latency=872.936484ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 22 13:05:12 volumiopi5 volumio[917]: verbose: New Socket.io Connection to 192.168.1.121 from 192.168.1.110 UA: Mozilla/5.0 (Linux; Android 12; W10 Pro Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.79 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 22 13:05:12 volumiopi5 sudo[14318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 13:05:12 volumiopi5 sudo[14318]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 13:05:12 volumiopi5 sudo[14318]: pam_unix(sudo:session): session closed for user root Feb 22 13:05:12 volumiopi5 sudo[14321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 13:05:12 volumiopi5 sudo[14321]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 13:05:12 volumiopi5 sudo[14321]: pam_unix(sudo:session): session closed for user root Feb 22 13:05:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 22 13:05:12 volumiopi5 volumio[917]: verbose: New Socket.io Connection to 192.168.1.121 from 192.168.1.110 UA: Mozilla/5.0 (Linux; Android 12; W10 Pro Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.79 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 22 13:05:12 volumiopi5 volumio[917]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 22 13:05:12 volumiopi5 volumio[917]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 13:05:12 volumiopi5 volumio[917]: TypeError: Cannot read property 'slice' of null Feb 22 13:05:12 volumiopi5 volumio[917]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 22 13:05:12 volumiopi5 volumio[917]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 22 13:05:12 volumiopi5 volumio[917]: at Object.onceWrapper (events.js:422:26) Feb 22 13:05:12 volumiopi5 volumio[917]: at ClientRequest.emit (events.js:315:20) Feb 22 13:05:12 volumiopi5 volumio[917]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Feb 22 13:05:12 volumiopi5 volumio[917]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Feb 22 13:05:12 volumiopi5 volumio[917]: at TLSSocket.socketOnData (_http_client.js:509:22) Feb 22 13:05:12 volumiopi5 volumio[917]: at TLSSocket.emit (events.js:315:20) Feb 22 13:05:12 volumiopi5 volumio[917]: at addChunk (internal/streams/readable.js:309:12) Feb 22 13:05:12 volumiopi5 volumio[917]: at readableAddChunk (internal/streams/readable.js:284:9) Feb 22 13:05:12 volumiopi5 volumio[917]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Feb 22 13:05:12 volumiopi5 volumio[917]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Feb 22 13:05:12 volumiopi5 volumio[917]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 13:05:13 volumiopi5 sudo[14332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-22 13:04 Feb 22 13:05:13 volumiopi5 sudo[14332]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"