Oct 12 22:47:00 volumiorpi4 startx[1782]: (==) Using config directory: "/etc/X11/xorg.conf.d" Oct 12 22:47:00 volumiorpi4 startx[1782]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Oct 12 22:47:00 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:00 volumiorpi4 volumio5-onboarding[1629]: time=2026-10-12T22:47:00.128+01:00 level=INFO msg="system info for 9721291f23f71ee2ddd49a363aa42bb2" deviceName=VolumioRPi4 deviceVariant=volumio deviceModel= softwareVersion=4.119 Oct 12 22:47:00 volumiorpi4 volumio5-onboarding[1629]: time=2026-10-12T22:47:00.134+01:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 12 22:47:00 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: touch_display: systemctl stop getty@tty1.service succeeded. Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: touch_display: systemctl disable getty@tty1.service succeeded. Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: touch_display: Volumio Kiosk started. Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: Completed starting Core Plugins Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: ------------------------------------------- Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: ----- MyVolumio plugins startup ---- Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: ------------------------------------------- Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: touch_display: IframeKeyboardBridge extension installed successfully Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Oct 12 22:47:00 volumiorpi4 sudo[1804]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/10-0045/brightness Oct 12 22:47:00 volumiorpi4 sudo[1804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:00 volumiorpi4 sudo[1804]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: New Spotify access tokenBQDEvQ36N6... Oct 12 22:47:00 volumiorpi4 volumio[1335]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 12 22:47:00 volumiorpi4 sudo[1806]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Oct 12 22:47:00 volumiorpi4 sudo[1806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:00 volumiorpi4 sudo[1806]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:00 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:00+01:00" level=info msg="running go-librespot 0.9.1" Oct 12 22:47:00 volumiorpi4 sudo[1809]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 12 22:47:00 volumiorpi4 sudo[1809]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:00 volumiorpi4 sudo[1809]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:00 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 22:47:00 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:00+01:00" level=debug msg="app state loaded" Oct 12 22:47:01 volumiorpi4 volumio[1335]: error: MPD error: The expression evaluated to a falsy value: Oct 12 22:47:01 volumiorpi4 volumio[1335]: assert.ok(self.idling) Oct 12 22:47:01 volumiorpi4 volumio[1335]: error: The expression evaluated to a falsy value: Oct 12 22:47:01 volumiorpi4 volumio[1335]: assert.ok(self.idling) Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=info msg="zeroconf server listening on port 46835" Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: touch_display: X display number found: 0 Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: MPD running with PID1648 Oct 12 22:47:01 volumiorpi4 volumio[1335]: ,establishing connection Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=info msg="loading previously persisted zeroconf credentials" username="wq*********************e7" Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: Starting Shairport Sync Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="obtained new client token: AAFALijoPePM9a34zEoxKAh0pktbMbPyDwOK2pHy9vOFV/4WgGER2eGY2svPhWx1fXj+VqcsJju8R+XR+B9k4Iid5/igJ6nOe5Et6vNF5NFUCJNEfQot1iL7ROeDzAd5/+ifdGxDhk9wL9PsMNR3RtBGxK50pWu9lLU3T2cD6YfNPzKKhxQXLYnvf4zHT1OkTooRBbdUWjvCBgjMXcaAqGW9rpNwdoXrC5AStLqE+0aPU6kov+5VyQ==" Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: Starting Shairport Sync Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 12 22:47:01 volumiorpi4 sudo[1835]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="completed keyexchange" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="completed challenge" Oct 12 22:47:01 volumiorpi4 sudo[1835]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: Starting Shairport Sync Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=info msg="authenticated AP" username="wq*********************e7" Oct 12 22:47:01 volumiorpi4 sudo[1837]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 22:47:01 volumiorpi4 sudo[1837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:01 volumiorpi4 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 22:47:01 volumiorpi4 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 22:47:01 volumiorpi4 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 22:47:01 volumiorpi4 systemd[1]: shairport-sync.service: Consumed 1.549s CPU time. Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=info msg="authenticated Login5" username="wq*********************e7" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="initializing zeroconf session" username="wq*********************e7" Oct 12 22:47:01 volumiorpi4 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="connected to gew1-dealer.spotify.com:443" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=trace msg="starting accesspoint recv loop" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 12 22:47:01 volumiorpi4 sudo[1835]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=trace msg="starting dealer recv loop" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="received connection id: NmQxNzUxN2EtZTlm...QzQyOUY0ODVFOA==" Oct 12 22:47:01 volumiorpi4 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 22:47:01 volumiorpi4 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 22:47:01 volumiorpi4 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 22:47:01 volumiorpi4 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 22:47:01 volumiorpi4 sudo[1837]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=debug msg="put connect state because NEW_DEVICE" Oct 12 22:47:01 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:01+01:00" level=trace msg="emitting websocket event: playback_ready" Oct 12 22:47:01 volumiorpi4 sudo[1841]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 22:47:01 volumiorpi4 sudo[1841]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:01 volumiorpi4 volumio[1335]: error: updateQueue error: null Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Oct 12 22:47:01 volumiorpi4 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 22:47:01 volumiorpi4 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 22:47:01 volumiorpi4 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Oct 12 22:47:01 volumiorpi4 volumio[1335]: info: touch_display: File permissions for backlight brightness control set. Oct 12 22:47:01 volumiorpi4 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 22:47:01 volumiorpi4 sudo[1841]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:02 volumiorpi4 sudo[1880]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 12 22:47:02 volumiorpi4 sudo[1880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:02 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:02+01:00" level=debug msg="avahi service \"VolumioRPi4\" established" Oct 12 22:47:02 volumiorpi4 volumio[1335]: info: Shairport-Sync Started Oct 12 22:47:02 volumiorpi4 volumio[1335]: Error adding Membership: Error: addMembership EINVAL Oct 12 22:47:02 volumiorpi4 volumio[1335]: info: Shairport-Sync Started Oct 12 22:47:02 volumiorpi4 volumio[1335]: info: Shairport-Sync Started Oct 12 22:47:02 volumiorpi4 volumio[1335]: info: touch_display: X display number found: 0 Oct 12 22:47:02 volumiorpi4 volumio[1335]: error: updateQueue error: null Oct 12 22:47:02 volumiorpi4 volumio[1335]: error: touch_display: Error setting display brightness: Error: EINVAL: invalid argument, write Oct 12 22:47:02 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:02 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:02 volumiorpi4 volumio[1335]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 12 22:47:03 volumiorpi4 volumio[1335]: SPOTIFY: User informations: {"account_id":"lSJYO9aa7L","country":"PL","display_name":"marklar","email":"rafal.razmus+pl@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/wqd62hokd5990qqmooljtkae7"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/wqd62hokd5990qqmooljtkae7","id":"wqd62hokd5990qqmooljtkae7","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee859ce6de2c376614c14ebbd195","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b829ce6de2c376614c14ebbd195","width":64}],"product":"premium","type":"user","uri":"spotify:user:wqd62hokd5990qqmooljtkae7"} Oct 12 22:47:03 volumiorpi4 volumio[1335]: info: Spotify Successfully logged in Oct 12 22:47:03 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 22:47:03 volumiorpi4 volumio[1335]: info: [1791841623238] CoreMusicLibrary::Adding element Spotify Oct 12 22:47:03 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 22:47:03 volumiorpi4 volumio[1335]: Cannot find translation for source Spotify Oct 12 22:47:03 volumiorpi4 volumio[1335]: info: go-librespot daemon successfully initialized Oct 12 22:47:06 volumiorpi4 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 12 22:47:07 volumiorpi4 volumio-remote-updater[840]: [2026-10-12 22:47:07] [connect] Successful connection Oct 12 22:47:07 volumiorpi4 volumio[1335]: info: Initializing connection to go-librespot Websocket Oct 12 22:47:07 volumiorpi4 systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 12 22:47:07 volumiorpi4 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 12 22:47:08 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:08+01:00" level=debug msg="new websocket client" Oct 12 22:47:08 volumiorpi4 volumio-remote-updater[840]: [2026-10-12 22:47:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1791841627 101 Oct 12 22:47:08 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 4 Oct 12 22:47:09 volumiorpi4 volumio[1335]: info: Connection to go-librespot Websocket established Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: Adding plugin bluetooth to MyMusic Plugins Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: Adding plugin multiroom to MyMusic Plugins Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: Adding plugin metavolumio to MyMusic Plugins Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: Adding plugin cd_controller to MyMusic Plugins Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 12 22:47:10 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 12 22:47:10 volumiorpi4 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Oct 12 22:47:10 volumiorpi4 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 22:47:10 volumiorpi4 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 22:47:10 volumiorpi4 sudo[1880]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:16 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 12 22:47:16 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 12 22:47:16 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:16 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:16 volumiorpi4 volumio[1335]: info: Starting MyVolumio Remote Streaming Endpoints Oct 12 22:47:16 volumiorpi4 volumio[1335]: info: MyVolumio login type: Token Oct 12 22:47:17 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 12 22:47:17 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: Streaming services startup Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: Starting Streaming Daemon Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 12 22:47:22 volumiorpi4 sudo[2152]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 12 22:47:22 volumiorpi4 sudo[2152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:22 volumiorpi4 sudo[2152]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: Getting Spotify volume Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: Bluetoothremote--- Checking for trusted devices to reconnect... Oct 12 22:47:22 volumiorpi4 volumio[1335]: info: Bluetoothremote--- Device list cleared and placeholder written. Oct 12 22:47:23 volumiorpi4 volumio[1335]: error: Cannot start Volumio Streaming Daemon Oct 12 22:47:23 volumiorpi4 volumio[1335]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 12 22:47:23 volumiorpi4 volumio[1335]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 12 22:47:23 volumiorpi4 volumio[1335]: info: Upmpdcli Daemon Started Oct 12 22:47:23 volumiorpi4 bluetoothd[951]: Path / reserved for Adv Monitor app :1.26 Oct 12 22:47:23 volumiorpi4 bluetoothd[951]: Adv Monitor app :1.26 disconnected from D-Bus Oct 12 22:47:23 volumiorpi4 volumio[1335]: info: Spotify volume: 100 Oct 12 22:47:23 volumiorpi4 bluetoothd[951]: Path / reserved for Adv Monitor app :1.27 Oct 12 22:47:23 volumiorpi4 bluetoothd[951]: Adv Monitor app :1.27 disconnected from D-Bus Oct 12 22:47:23 volumiorpi4 volumio[1335]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 22:47:23 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 12 22:47:23 volumiorpi4 volumio[1335]: info: Bluetoothremote--- Reconnecting trusted device: Keyboard K380 (34:88:5D:C2:18:47) Oct 12 22:47:23 volumiorpi4 bluetoothd[951]: Path / reserved for Adv Monitor app :1.28 Oct 12 22:47:23 volumiorpi4 volumio[1335]: error: MyVolumio Custom Token format not valid, refreshing it Oct 12 22:47:23 volumiorpi4 volumio[1335]: info: Bluetoothremote--- Device found: Press scan to detect BT device - xx Oct 12 22:47:24 volumiorpi4 bluetoothd[951]: Path / reserved for Adv Monitor app :1.29 Oct 12 22:47:24 volumiorpi4 bluetoothd[951]: Adv Monitor app :1.29 disconnected from D-Bus Oct 12 22:47:24 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:24 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:24 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:47:24 volumiorpi4 volumio[1335]: SPOTIFY: SPOTIFY VOLUME 100 Oct 12 22:47:24 volumiorpi4 volumio[1335]: SPOTIFY: VOLUMIO VOLUME 78 Oct 12 22:47:24 volumiorpi4 volumio[1335]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 12 22:47:24 volumiorpi4 volumio[1335]: info: Setting Spotify Volume from Volumio: 78 Oct 12 22:47:25 volumiorpi4 volumio[1335]: info: MyVolumio login type: Token Oct 12 22:47:25 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 22:47:25 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:25 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 22:47:25 volumiorpi4 volumio-remote-updater[840]: Test mode disabled Oct 12 22:47:25 volumiorpi4 volumio-remote-updater[840]: Alpha mode disabled Oct 12 22:47:25 volumiorpi4 volumio-remote-updater[840]: Alpha legacy test mode disabled Oct 12 22:47:25 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:26 volumiorpi4 volumio5-onboarding[1629]: time=2026-10-12T22:47:26.342+01:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Oct 12 22:47:26 volumiorpi4 volumio5-onboarding[1629]: time=2026-10-12T22:47:26.344+01:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Oct 12 22:47:26 volumiorpi4 volumio5-onboarding[1629]: time=2026-10-12T22:47:26.345+01:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 12 22:47:26 volumiorpi4 volumio[1335]: SPOTIFY: SETTING SPOTIFY VOLUME 78 Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: Sending Spotify command with payload to local API: /player/volume Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:26 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:26+01:00" level=debug msg="update volume requested to 51117/65535" Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:26 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 22:47:26 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:26+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Oct 12 22:47:26 volumiorpi4 go-librespot[1776]: time="2026-10-12T22:47:26+01:00" level=trace msg="emitting websocket event: volume" Oct 12 22:47:26 volumiorpi4 volumio[1335]: SPOTIFY: received: {"type":"volume","data":{"max":100,"value":78}} Oct 12 22:47:26 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED SPOTIFY VOLUME 78 Oct 12 22:47:27 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/153.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 12 22:47:28 volumiorpi4 bluetoothd[951]: profiles/input/device.c:control_connect_cb() connect to 34:88:5D:C2:18:47: Host is down (112) Oct 12 22:47:28 volumiorpi4 bluetoothd[951]: Adv Monitor app :1.28 disconnected from D-Bus Oct 12 22:47:28 volumiorpi4 volumio[1335]: error: Bluetoothremote--- Failed to reconnect Keyboard K380: Command failed: bluetoothctl connect 34:88:5D:C2:18:47 Oct 12 22:47:28 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:29 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 22:47:29 volumiorpi4 volumio[1335]: info: MyVolumio token set successfully Oct 12 22:47:29 volumiorpi4 volumio[1335]: info: MYVOLUMIO: Adding device Oct 12 22:47:29 volumiorpi4 volumio[1335]: info: MYVOLUMIO: Evaluating Server Oct 12 22:47:29 volumiorpi4 volumio5-onboarding[1629]: time=2026-10-12T22:47:29.861+01:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=XiQvyZJpRWQHwNSuiYAk6zcHNzn2 tokenExpiry=2026-10-12T23:47:29.861+01:00 Oct 12 22:47:30 volumiorpi4 volumio5-onboarding[1629]: failed to bootstrap state: failed to get logged user: could not get user info: failed to fetch user info: Get "https://myvolumio.firebaseio.com/users/XiQvyZJpRWQHwNSuiYAk6zcHNzn2.json?auth=eyJhbGciOiJSUzI1NiIsImtpZCI6IjkwNGIwZjkxYmU2ZWIwODY3ZGFiYmFhYjU4N2RmYzJlMzNmMDBhMjQiLCJ0eXAiOiJKV1QifQ.eyJpc3MiOiJodHRwczovL3NlY3VyZXRva2VuLmdvb2dsZS5jb20vbXl2b2x1bWlvIiwiYXVkIjoibXl2b2x1bWlvIiwiYXV0aF90aW1lIjoxNzkxODQxNjQ5LCJ1c2VyX2lkIjoiWGlRdnlaSnBSV1FId05TdWlZQWs2emNITnpuMiIsInN1YiI6IlhpUXZ5WkpwUldRSHdOU3VpWUFrNnpjSE56bjIiLCJpYXQiOjE3OTE4NDE2NDksImV4cCI6MTc5MTg0NTI0OSwiZW1haWwiOiJyYWZhbC5yYXptdXNAZ21haWwuY29tIiwiZW1haWxfdmVyaWZpZWQiOnRydWUsImZpcmViYXNlIjp7ImlkZW50aXRpZXMiOnsiZW1haWwiOlsicmFmYWwucmF6bXVzQGdtYWlsLmNvbSJdfSwic2lnbl9pbl9wcm92aWRlciI6ImN1c3RvbSJ9fQ.00NIO5POzLmPWHcj9zMRjaVedL2xt2OQ6XMfWwORqwP5xXIwQY2nX5S8yXES2wMJQxNvUKYgROJvg7DGvx2_TRK448sKtVzNx7xpJePhNhfzh7sm5y-Pi5E6opjy7C8tII318gyQD04mOIAl8IWNijJ5zgRQFSpWf3tCiQNWbDTXKkP-pCpvPjyQRQxUL_TurR7dBRiHOZl0Drb0GrzW2x5rxQ6mYPFiTimplwjek2420rOoW-Nkem4WrdDH8puKlLYTvLWoDZvk1srV5E-60aAROFBhMXKQI7XFkjmxj7HVSndIrXJ556LDJ-oLiPzNgSsnSLgoS7L7-UbXu1t8KA": context deadline exceeded Oct 12 22:47:30 volumiorpi4 systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 12 22:47:30 volumiorpi4 systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: MyVolumio status changed Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Streaming services startup Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Starting Streaming Daemon Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Removing browser output: myVolumio user plan is not superstar Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Removing audio output: Oct 12 22:47:30 volumiorpi4 sudo[2195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Stoppping Tunnel 1 Oct 12 22:47:30 volumiorpi4 sudo[2195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:30 volumiorpi4 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Oct 12 22:47:30 volumiorpi4 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 12 22:47:30 volumiorpi4 systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 12 22:47:30 volumiorpi4 sudo[2198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 12 22:47:30 volumiorpi4 sudo[2198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 22:47:30 volumiorpi4 sudo[2195]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:30 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:30.564+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Setting Geolocation for MyVolumio to eu3 Oct 12 22:47:30 volumiorpi4 systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 22:47:30 volumiorpi4 systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 22:47:30 volumiorpi4 systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:30 volumiorpi4 systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 22:47:30 volumiorpi4 systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 22:47:30 volumiorpi4 systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 22:47:30 volumiorpi4 sudo[2198]: pam_unix(sudo:session): session closed for user root Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Remote SSH Stopped Oct 12 22:47:30 volumiorpi4 volumio[1335]: error: Cannot start Volumio Streaming Daemon Oct 12 22:47:30 volumiorpi4 volumio[1335]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 12 22:47:30 volumiorpi4 volumio[1335]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 12 22:47:30 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 12 22:47:30 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:30 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:30.920+01:00 level=INFO msg="system info for 9721291f23f71ee2ddd49a363aa42bb2" deviceName=VolumioRPi4 deviceVariant=volumio deviceModel= softwareVersion=4.119 Oct 12 22:47:30 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:30.924+01:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:30 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:31 volumiorpi4 volumio-remote-updater[840]: Test mode disabled Oct 12 22:47:31 volumiorpi4 volumio-remote-updater[840]: Alpha mode disabled Oct 12 22:47:31 volumiorpi4 volumio-remote-updater[840]: Alpha legacy test mode disabled Oct 12 22:47:31 volumiorpi4 volumio[1335]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 12 22:47:31 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/153.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: Updating MyVolumio device info Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:31 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 22:47:32 volumiorpi4 volumio[1335]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 12 22:47:32 volumiorpi4 volumio[1335]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 12 22:47:32 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:32.576+01:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Oct 12 22:47:32 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:32.577+01:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Oct 12 22:47:32 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:32.577+01:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: Listing playlists Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:32 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:33 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:33 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 22:47:33 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:33 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:34 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 22:47:34 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 22:47:34 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 12 22:47:34 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:34.917+01:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=XiQvyZJpRWQHwNSuiYAk6zcHNzn2 tokenExpiry=2026-10-12T23:47:34.917+01:00 Oct 12 22:47:35 volumiorpi4 volumio[1335]: info: MYVOLUMIO: Adding device Oct 12 22:47:35 volumiorpi4 volumio[1335]: info: MYVOLUMIO: Evaluating Server Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 22:47:36 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:36.503+01:00 level=INFO msg="enabling local network discovery" Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: Setting Geolocation for MyVolumio to eu3 Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:36 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:36.535+01:00 level=INFO msg="enabling BLE discovery" Oct 12 22:47:36 volumiorpi4 volumio[1335]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 22:47:36 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 22:47:37 volumiorpi4 volumio5-onboarding[2199]: time=2026-10-12T22:47:37.405+01:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 22:47:37 volumiorpi4 volumio[1335]: info: Updating MyVolumio device info Oct 12 22:47:37 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:37 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:37 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:37 volumiorpi4 volumio[1335]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 12 22:47:41 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 12 22:47:41 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetQueue Oct 12 22:47:41 volumiorpi4 volumio[1335]: info: CoreStateMachine::getQueue Oct 12 22:47:41 volumiorpi4 volumio[1335]: info: CorePlayQueue::getQueue Oct 12 22:47:42 volumiorpi4 volumio[1335]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 12 22:47:42 volumiorpi4 volumio[1335]: info: Completed starting MyVolumio Plugin Oct 12 22:47:42 volumiorpi4 volumio[1335]: [Metrics] CommandRouter: 65s 563.22ms Oct 12 22:47:42 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumiosetStartupVolume Oct 12 22:47:42 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 22:47:42 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 22:47:42 volumiorpi4 volumio[1335]: info: CoreCommandRouter::Close All Modals sent Oct 12 22:47:42 volumiorpi4 volumio[1335]: info: CoreCommandRouter::Close All Modals sent Oct 12 22:47:43 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 12 22:47:43 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 22:47:43 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 12 22:47:47 volumiorpi4 upmpdcli[2273]: writing RSA key Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: Received Get System Version Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: Received Get System Info Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: Discovery: Getting this device information Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioGetState Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:47:48 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 22:47:49 volumiorpi4 volumio[1335]: info: BOOT COMPLETED Oct 12 22:47:53 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 22:47:53 volumiorpi4 volumio[1335]: info: CURURI: music-library Oct 12 22:47:54 volumiorpi4 volumio[1335]: info: Preload queue cleared Oct 12 22:47:57 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 22:47:57 volumiorpi4 volumio[1335]: info: CURURI: music-library/USB Oct 12 22:47:57 volumiorpi4 volumio[1335]: info: Preload queue cleared Oct 12 22:47:58 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 22:47:58 volumiorpi4 volumio[1335]: info: CURURI: music-library/USB/ext_ssd Oct 12 22:47:58 volumiorpi4 volumio[1335]: info: Preload queue cleared Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Preload queue cleared Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::ClearQueue Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::stop Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::clearPlayQueue Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::saveQueue Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushQueue Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::addQueueItems Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::addQueueItems Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Preload queue cleared Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Adding Item to queue: music-library/USB/ext_ssd/Ævangelist Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Exploding uri music-library/USB/ext_ssd/Ævangelist in service mpd Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F01%20-%20Anno%20mortii%20-%20Gnostic%20Transcendental%20Heresy.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F02%20-%20Pendulum.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/02 - Pendulum.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F03%20-%20Death%20Illumination.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/03 - Death Illumination.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F04%20-%20Funeral%20Monolith.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/04 - Funeral Monolith.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F05%20-%20Hierophant%20Disposal%20Facility.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/05 - Hierophant Disposal Facility.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F06%20-%20The%20Longevity%20of%20Second%20Death.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/06 - The Longevity of Second Death.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F07%20-%20Blood%20%26%20Darkness.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/07 - Blood & Darkness.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=%C3%86vangelist/De%20Masticatione%20Mortuorum%20In%20Tumulis/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2F%C3%86vangelist%2F%C3%86vangelist%20-%20De%20Masticatione%20Mortuorum%20In%20Tumulis%2F08%20-%20Crematorium%20Angelicum.mp3&metadata=false Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/08 - Crematorium Angelicum.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushQueue Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::saveQueue Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::updateTrackBlock Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrackBlock Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPlay Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::play index 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::stop Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::play index undefined Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::startPlaybackTimer Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::clearAddPlayTracks USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3 Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand stop took 76 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces system playlist update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Ignoring MPD Status Update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand clear took 2 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand add "USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3" Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces system playlist update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Ignoring MPD Status Update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces system playlist update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Ignoring MPD Status Update Oct 12 22:48:05 volumiorpi4 volumio[1335]: error: updateQueue error: null Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces system playlist update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Ignoring MPD Status Update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ------------------------------ 67ms Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand add "USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3" took 65 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ------------------------------ 65ms Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ------------------------------ 64ms Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces system playlist update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Ignoring MPD Status Update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces system playlist update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Ignoring MPD Status Update Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces state update: player Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ------------------------------ 30ms Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand play took 28 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ------------------------------ 29ms Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ------------------------------ 23ms Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::getState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces state update: player Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::getState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces state update: player Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::getState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces state update: player Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::getState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand status took 48 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces state update: player Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::getState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand status took 87 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand status took 86 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand status took 41 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand status took 38 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::servicePushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":627,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Anno Mortii : Gnostic Transcendental Heresy","artist":"Ævangelist","album":"De Masticatione Mortuorum In Tumulis","uri":"USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3","trackType":"mp3"} Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: CURRENT POSITION 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState stateService play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState currentStatus stop Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ------------------------------ 97ms Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Oct 12 22:48:05 volumiorpi4 volumio[1335]: ---------------------------- MPD announces state update: player Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::getState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: sendMpdCommand status took 7 milliseconds Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseState Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::servicePushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":627,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Anno Mortii : Gnostic Transcendental Heresy","artist":"Ævangelist","album":"De Masticatione Mortuorum In Tumulis","uri":"USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3","trackType":"mp3"} Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: CURRENT POSITION 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState stateService play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Received an update from plugin. extracting info from payload Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::servicePushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":627,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Anno Mortii : Gnostic Transcendental Heresy","artist":"Ævangelist","album":"De Masticatione Mortuorum In Tumulis","uri":"USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3","trackType":"mp3"} Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: CURRENT POSITION 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState stateService play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Received an update from plugin. extracting info from payload Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::servicePushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":627,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Anno Mortii : Gnostic Transcendental Heresy","artist":"Ævangelist","album":"De Masticatione Mortuorum In Tumulis","uri":"USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3","trackType":"mp3"} Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: CURRENT POSITION 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState stateService play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Received an update from plugin. extracting info from payload Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: ControllerMpd::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::servicePushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":627,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Anno Mortii : Gnostic Transcendental Heresy","artist":"Ævangelist","album":"De Masticatione Mortuorum In Tumulis","uri":"USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3","trackType":"mp3"} Oct 12 22:48:05 volumiorpi4 volumio[1335]: verbose: CURRENT POSITION 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState stateService play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: Received an update from plugin. extracting info from payload Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:05 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: ------------------------------ 492ms Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: ------------------------------ 491ms Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: ------------------------------ 524ms Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: ------------------------------ 478ms Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: sendMpdCommand playlistinfo took 429 milliseconds Oct 12 22:48:06 volumiorpi4 volumio[1335]: verbose: ControllerMpd::parseTrackInfo Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: ControllerMpd::pushState Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CoreCommandRouter::servicePushState Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:06 volumiorpi4 volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":627,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Anno Mortii : Gnostic Transcendental Heresy","artist":"Ævangelist","album":"De Masticatione Mortuorum In Tumulis","uri":"USB/ext_ssd/Ævangelist/Ævangelist - De Masticatione Mortuorum In Tumulis/01 - Anno mortii - Gnostic Transcendental Heresy.mp3","trackType":"mp3"} Oct 12 22:48:06 volumiorpi4 volumio[1335]: verbose: CURRENT POSITION 0 Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState stateService play Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CoreStateMachine::syncState currentStatus play Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: Received an update from plugin. extracting info from payload Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:06 volumiorpi4 volumio[1335]: info: ------------------------------ 565ms Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:06 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: Preload queue cleared Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::ClearQueue Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::stop Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::stPlaybackTimer Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::updateTrackBlock Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrackBlock Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::pushState Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushState Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::serviceStop Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CorePlayQueue::getTrack 0 Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreCommandRouter::serviceStop Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: ControllerMpd::stop Oct 12 22:48:15 volumiorpi4 volumio[1335]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CorePlayQueue::clearPlayQueue Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CorePlayQueue::saveQueue Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreCommandRouter::volumioPushQueue Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CoreStateMachine::addQueueItems Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: CorePlayQueue::addQueueItems Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: Preload queue cleared Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: Adding Item to queue: music-library/USB/ext_ssd/Behemoth Oct 12 22:48:15 volumiorpi4 volumio[1335]: info: Exploding uri music-library/USB/ext_ssd/Behemoth in service mpd Oct 12 22:48:16 volumiorpi4 volumio[1335]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: Oct 12 22:48:16 volumiorpi4 volumio[1335]: ---------------------------- MPD announces state update: player Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F01%20-%20The%20Chant%20from%20the%20eastern%20lands.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/01 - The Chant from the eastern lands.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F02%20-%20The%20Touch%20of%20Nya.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/02 - The Touch of Nya.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F03%20-%20From%20the%20Pagan%20Vastlands.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/03 - From the Pagan Vastlands.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F04%20-%20Hidden%20in%20a%20Fog.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/04 - Hidden in a Fog.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F05%20-%20Ancient.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/05 - Ancient.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F06%20-%20Entering%20the%20Faustian%20Soul.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/06 - Entering the Faustian Soul.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F07%20-%20Forgotten%20Cult%20of%20Aldaron.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/07 - Forgotten Cult of Aldaron.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F08%20-%20Wolves%20Guard%20My%20Coffin.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/08 - Wolves Guard My Coffin.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F09%20-%20Hell%20Dwells%20In%20Ice.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/09 - Hell Dwells In Ice.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F10%20-%20The%20Dark%20Triumph.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/10 - The Dark Triumph.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F11%20-%20Cursed%20Angel%20Of%20Doom.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/11 - Cursed Angel Of Doom.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F12%20-%20Transylvanien%20Forest.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/12 - Transylvanien Forest.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F13%20-%20Moonspell%20Rites.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/13 - Moonspell Rites.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F14%20-%20Sventevith%20(Storming%20Near%20The%20Baltic).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/14 - Sventevith (Storming Near The Baltic).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F15%20-%20Pure%20Evil%20and%20Hate.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/15 - Pure Evil and Hate.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Storms%20To%20Unleash%20(Chaotica)/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FStorms%20To%20Unleash%20CD1%2F16%20-%20Forgotten%20Empire%20of%20Dark%20Witchcraft.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Storms To Unleash CD1/16 - Forgotten Empire of Dark Witchcraft.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F01%20-%20Intro.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/01 - Intro.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F02%20-%20The%20Dark%20Forest.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/02 - The Dark Forest.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F03%20-%20Spellcraft%20and%20Heathendom.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/03 - Spellcraft and Heathendom.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F04%20-%20Dragons%20Liar.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/04 - Dragons Liar.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F05%20-%20Lasy%20Pomorza.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/05 - Lasy Pomorza.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F06%20-%20Rising%20Proudly%20Towards%20The%20Sky.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/06 - Rising Proudly Towards The Sky.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F07%20-%20Thou%20Shalt%20Forever%20Win.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/07 - Thou Shalt Forever Win.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F08%20-%20Grom.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/08 - Grom.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F09%20-%20Total%20Disaster.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/09 - Total Disaster.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F10%20-%20Freezing%20Moon.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/10 - Freezing Moon.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F11%20-%20With%20Spell%20Of%20Inferno.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/11 - With Spell Of Inferno.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F12%20-%20Hidden%20In%20A%20Fog.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/12 - Hidden In A Fog.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Chaotica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Chaotica%2FThunders%20To%20Erupt%20CD2%2F13%20-%20Sventevith%20(storming%20near%20the%20Baltic).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Chaotica/Thunders To Erupt CD2/13 - Sventevith (storming near the Baltic).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F01%20-%20Antichristian%20Phenomenon.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/01 - Antichristian Phenomenon.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F02%20-%20From%20The%20Pagan%20Vastlands.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/02 - From The Pagan Vastlands.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F03%20-%20Heru%20Ra%20Ha%20(Let%20There%20Be%20Might).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/03 - Heru Ra Ha (Let There Be Might).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F04%20-%20Christians%20To%20The%20Lions.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/04 - Christians To The Lions.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F05%20-%20Hekau%20718.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/05 - Hekau 718.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F06%20-%20No%20Sympathy%20For%20Fools.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/06 - No Sympathy For Fools.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F07%20-%20Decade%20Ov%20Therion.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/07 - Decade Ov Therion.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F08%20-%20As%20Above%20So%20Below.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/08 - As Above So Below.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F09%20-%20Chant%20For%20Eskhaton%202000.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/09 - Chant For Eskhaton 2000.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F10%20-%20Pure%20Evil%20And%20Hate.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/10 - Pure Evil And Hate.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F11%20-%20Christians%20To%20The%20Lions.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/11 - Christians To The Lions.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F12%20-%20Decade%20Ov%20Therion.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/12 - Decade Ov Therion.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F13%20-%20From%20The%20Pagan%20Vastlands.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/13 - From The Pagan Vastlands.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F14%20-%20Antichristian%20Phenomenon.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/14 - Antichristian Phenomenon.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F15%20-%20Lam.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/15 - Lam.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F16%20-%20Satans%20Sword.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/16 - Satans Sword.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Crush.Fukk.Create/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Crush.Fukk.Create%2F17%20-%20Chant%20For%20Eskhaton%202000.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Crush.Fukk.Create/17 - Chant For Eskhaton 2000.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F01%20-%20Sculpting%20The%20Throne%20Ov%20Seth.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/01 - Sculpting The Throne Ov Seth.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F02%20-%20Demigod.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/02 - Demigod.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F03%20-%20Conquer%20All.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/03 - Conquer All.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F04%20-%20The%20Nephilim%20Rising.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/04 - The Nephilim Rising.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F05%20-%20Towards%20Babylon.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/05 - Towards Babylon.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F06%20-%20Before%20Aeons%20Came.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/06 - Before Aeons Came.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F07%20-%20Myterium%20Coniunctionis%20(Hermanubis).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/07 - Myterium Coniunctionis (Hermanubis).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F08%20-%20Xul.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/08 - Xul.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F09%20-%20Slaves%20Shall%20Server.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/09 - Slaves Shall Server.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demigod/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demigod%2F10%20-%20The%20Reign%20Ov%20Shemsu%20-%20Hor.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demigod/10 - The Reign Ov Shemsu - Hor.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F01%20-%20Of%20My%20Worship%20(Intro).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/01 - Of My Worship (Intro).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F02%20-%20Summoning%20Of%20The%20Ancient%20Gods.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/02 - Summoning Of The Ancient Gods.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F03%20-%20The%20Arrival%20(Instrumental).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/03 - The Arrival (Instrumental).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F04%20-%20Dark%20Triumph.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/04 - Dark Triumph.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F05%20-%20Monumentum%20(Instrumental).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/05 - Monumentum (Instrumental).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F06%20-%20Rise%20Of%20The%20Blackstorm%20Of%20Evil.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/06 - Rise Of The Blackstorm Of Evil.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F07%20-%20Aggressor.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/07 - Aggressor.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F08%20-%20Goat%20With%20A%20Thousand%20Young%20(Instrumental).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/08 - Goat With A Thousand Young (Instrumental).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F09%20-%20Bless%20Thee%20For%20Granting%20Me%20Pain.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/09 - Bless Thee For Granting Me Pain.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F10%20-%20Cursed%20Angel%20Of%20Doom.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/10 - Cursed Angel Of Doom.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F11%20-%20Transylvanian%20Forest.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/11 - Transylvanian Forest.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F12%20-%20From%20Hornedlands%20To%20Lindisfarne.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/12 - From Hornedlands To Lindisfarne.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F13%20-%20Thy%20Winter%20Kingdom.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/13 - Thy Winter Kingdom.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F14%20-%20Summoning%20(Of%20The%20Ancient%20Ones).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/14 - Summoning (Of The Ancient Ones).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F15%20-%20The%20Dance%20Of%20The%20Pagan%20Flames.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/15 - The Dance Of The Pagan Flames.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F16%20-%20Blackvisions%20Of%20The%20Almighty.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/16 - Blackvisions Of The Almighty.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F17%20-%20Fields%20Of%20Haar-Meggido.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/17 - Fields Of Haar-Meggido.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F18%20-%20Deathcrush.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/18 - Deathcrush.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F19%20-%20Moonspell%20Rites.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/19 - Moonspell Rites.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F20%20-%20Blackvisions%20Of%20The%20Almighty.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/20 - Blackvisions Of The Almighty.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F21%20-%20Pure%20Evil%20And%20Hate.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/21 - Pure Evil And Hate.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F22%20-%20The%20Oak%20Between%20The%20Snows%20(Instrumental).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/22 - The Oak Between The Snows (Instrumental).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Demonica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Demonica%2F23%20-%20Spellcraft%20And%20Heathendom.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Demonica/23 - Spellcraft And Heathendom.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F01%20-%20Daimonos.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/01 - Daimonos.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F02%20-%20Shemhamforash.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/02 - Shemhamforash.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F03%20-%20Ov%20Fire%20And%20The%20Void.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/03 - Ov Fire And The Void.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F04%20-%20Transmigrating%20Beyong%20Realms%20Ov%20Amenti.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/04 - Transmigrating Beyong Realms Ov Amenti.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F05%20-%20He%20Who%20Breeds%20Pestilence.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/05 - He Who Breeds Pestilence.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F06%20-%20The%20Seed%20Ov%20I.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/06 - The Seed Ov I.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F07%20-%20Alas%2C%20The%20Lord%20Is%20Upon%20Me.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/07 - Alas, The Lord Is Upon Me.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F08%20-%20Defiling%20Morality%20Ov%20Black%20God.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/08 - Defiling Morality Ov Black God.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Evangelion/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Evangelion%2F09%20-%20Lucifer.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Evangelion/09 - Lucifer.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F01%20-%20Diableria%20(The%20Great%20Introduction).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/01 - Diableria (The Great Introduction).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F02%20-%20The%20Thousand%20Plagues%20I%20Witness.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/02 - The Thousand Plagues I Witness.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F03%20-%20Satan's%20Sword%20(I%20Have%20Become).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/03 - Satan's Sword (I Have Become).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F04%20-%20In%20Thy%20Pandemaeternum.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/04 - In Thy Pandemaeternum.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F05%20-%20Driven%20By%20the%20Five-Winged%20Star.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/05 - Driven By the Five-Winged Star.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F06%20-%20The%20Past%20is%20Like%20a%20Funeral.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/06 - The Past is Like a Funeral.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F07%20-%20The%20Entrance%20to%20the%20Spheres%20of%20Mars.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/07 - The Entrance to the Spheres of Mars.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F08%20-%20With%20Spell%20of%20Inferno.mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/08 - With Spell of Inferno.mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Pandemonic%20Incantation/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Pandemonic%20Incantations%2F09%20-%20Chwala%20Mordercom%20Wojciecha%20(997-1997%20dziesiec%20wiekow%20hanby).mp3&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Pandemonic Incantations/09 - Chwala Mordercom Wojciecha (997-1997 dziesiec wiekow hanby).mp3 Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Satanica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Satanica%20%5BFLAC%5D%2FBehemoth%20-%20Satanica.FLAC&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Satanica [FLAC]/Behemoth - Satanica.FLAC Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Satanica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Satanica%20%5BFLAC%5D%2FBehemoth%20-%20Satanica.cue&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Satanica [FLAC]/Behemoth - Satanica.cue Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: ALBUMART /albumart?cacheid=9&web=Behemoth/Satanica/extralarge&path=%2Fmnt%2FUSB%2Fext_ssd%2FBehemoth%2FBehemoth%20-%20Satanica%20%5BFLAC%5D%2FBehemoth%20-%20Satanica.cue&metadata=false Oct 12 22:48:16 volumiorpi4 volumio[1335]: info: URI /mnt/USB/ext_ssd/Behemoth/Behemoth - Satanica [FLAC]/Behemoth - Satanica.cue Oct 12 22:48:16 volumiorpi4 volumio[1335]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 22:48:16 volumiorpi4 volumio[1335]: Error: Unable to resolve or reject the same promise twice Oct 12 22:48:16 volumiorpi4 volumio[1335]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 12 22:48:16 volumiorpi4 volumio[1335]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at Socket.emit (node:events:514:28) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at addChunk (node:internal/streams/readable:343:12) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at Readable.push (node:internal/streams/readable:253:10) Oct 12 22:48:16 volumiorpi4 volumio[1335]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 12 22:48:16 volumiorpi4 volumio[1335]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 22:48:20 volumiorpi4 sudo[2377]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 22:47' Oct 12 22:48:20 volumiorpi4 sudo[2377]: 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"