-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2026-03-28 09:33:50 CET. -- Mar 28 09:32:15 volumio go-librespot[1301]: time="2026-03-28T09:32:15+01:00" level=trace msg="sent dealer ping" Mar 28 09:32:15 volumio go-librespot[1301]: time="2026-03-28T09:32:15+01:00" level=trace msg="received dealer pong" Mar 28 09:32:22 volumio volumio[987]: info: CoreCommandRouter::volumioPause Mar 28 09:32:22 volumio volumio[987]: info: CoreStateMachine::pause Mar 28 09:32:22 volumio volumio[987]: info: CoreStateMachine::stPlaybackTimer Mar 28 09:32:22 volumio volumio[987]: info: CoreStateMachine::servicePause Mar 28 09:32:22 volumio volumio[987]: info: CorePlayQueue::getTrack 26 Mar 28 09:32:22 volumio volumio[987]: info: CoreCommandRouter::servicePause Mar 28 09:32:22 volumio volumio[987]: info: Spotify Received pause Mar 28 09:32:22 volumio volumio[987]: SPOTIFY: SPOTIFY PAUSE Mar 28 09:32:22 volumio volumio[987]: SPOTIFY: {"status":"play","position":26,"title":"Zijn Het Je Ogen","artist":"Danny Vera","album":"The New Black and White, Pt. I, II, III & IV","albumart":"https://i.scdn.co/image/ab67616d0000b2737e4c68e697925ed31cc6c55e","uri":"spotify:track:3vthSX4hOUj6C3NZTjVv2k","trackType":"spotify","codec":"ogg","seek":251,"duration":165,"samplerate":"320 kbps","bitdepth":"16 bit","random":false,"repeat":false,"repeatSingle":false,"consume":false,"volume":52,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Mar 28 09:32:22 volumio volumio[987]: info: Sending Spotify command to local API: /player/pause Mar 28 09:32:23 volumio volumio[987]: info: CoreCommandRouter::volumioPause Mar 28 09:32:23 volumio volumio[987]: info: CoreStateMachine::pause Mar 28 09:32:25 volumio volumio[987]: info: CoreCommandRouter::volumioPause Mar 28 09:32:25 volumio volumio[987]: info: CoreStateMachine::pause Mar 28 09:32:29 volumio volumio[987]: info: CoreCommandRouter::volumioNext Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::next Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::stop Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 28 09:32:29 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::stPlaybackTimer Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::pushState Mar 28 09:32:29 volumio volumio[987]: info: CorePlayQueue::getTrack 26 Mar 28 09:32:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 09:32:29 volumio volumio[987]: info: CoreCommandRouter::volumioPushState Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::serviceStop Mar 28 09:32:29 volumio volumio[987]: info: CorePlayQueue::getTrack 26 Mar 28 09:32:29 volumio volumio[987]: info: CoreCommandRouter::serviceStop Mar 28 09:32:29 volumio volumio[987]: info: Spotify Stop Mar 28 09:32:29 volumio volumio[987]: SPOTIFY: SPOTIFY STOP Mar 28 09:32:29 volumio volumio[987]: SPOTIFY: {"status":"play","position":26,"title":"Zijn Het Je Ogen","artist":"Danny Vera","album":"The New Black and White, Pt. I, II, III & IV","albumart":"https://i.scdn.co/image/ab67616d0000b2737e4c68e697925ed31cc6c55e","uri":"spotify:track:3vthSX4hOUj6C3NZTjVv2k","trackType":"spotify","codec":"ogg","seek":251,"duration":165,"samplerate":"320 kbps","bitdepth":"16 bit","random":false,"repeat":false,"repeatSingle":false,"consume":false,"volume":52,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Mar 28 09:32:29 volumio volumio[987]: info: Sending Spotify command to local API: /player/pause Mar 28 09:32:29 volumio volumio5-onboarding[1906]: time=2026-03-28T09:32:29.426+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:55704 @ 0x2f329c0" state=STATUS_STOPPED positionMs=0 volume=52 Mar 28 09:32:29 volumio volumio5-onboarding[1906]: time=2026-03-28T09:32:29.427+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:55704 @ 0x2f329c0" id=spotify:track:3vthSX4hOUj6C3NZTjVv2k title="Zijn Het Je Ogen" Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:32:29 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 28 09:32:29 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:29 volumio volumio[987]: info: [1774686749433] ControllerSpotify::clearAddPlayTrack Mar 28 09:32:29 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 28 09:32:29 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 28 09:32:29 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 28 09:32:29 volumio volumio[987]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Mar 28 09:32:29 volumio volumio[987]: info: touch_display: Setting screensaver timeout to 60 seconds. Mar 28 09:32:34 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Mar 28 09:32:34 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 28 09:32:34 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:32:34 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:34 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 28 09:32:34 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:34 volumio volumio[987]: info: [1774686754139] ControllerSpotify::clearAddPlayTrack Mar 28 09:32:34 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 28 09:32:34 volumio systemd[1]: Starting Cleanup of Temporary Directories... Mar 28 09:32:34 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Mar 28 09:32:34 volumio systemd[1]: Started Cleanup of Temporary Directories. Mar 28 09:32:41 volumio volumio5-onboarding[1906]: time=2026-03-28T09:32:41.613+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.7.56:55704 @ 0x2f329c0" latency=13.447964ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Mar 28 09:32:41 volumio sudo[4182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 28 09:32:41 volumio sudo[4182]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 09:32:41 volumio sudo[4182]: pam_unix(sudo:session): session closed for user root Mar 28 09:32:41 volumio sudo[4185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 09:32:41 volumio sudo[4185]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 09:32:41 volumio sudo[4185]: pam_unix(sudo:session): session closed for user root Mar 28 09:32:41 volumio volumio[987]: verbose: New Socket.io Connection to 192.168.7.40 from 192.168.7.56 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Mar 28 09:32:41 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 28 09:32:42 volumio sudo[4188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 28 09:32:42 volumio sudo[4188]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 09:32:42 volumio sudo[4188]: pam_unix(sudo:session): session closed for user root Mar 28 09:32:42 volumio sudo[4191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 09:32:42 volumio sudo[4191]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 09:32:42 volumio sudo[4191]: pam_unix(sudo:session): session closed for user root Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 28 09:32:42 volumio volumio[987]: verbose: New Socket.io Connection to 192.168.7.40 from 192.168.7.56 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Mar 28 09:32:42 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 28 09:32:42 volumio volumio[987]: info: Received Get System Info Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 09:32:42 volumio volumio[987]: info: Discovery: Getting this device information Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Mar 28 09:32:42 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Mar 28 09:32:42 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:42 volumio volumio[987]: info: Listing playlists Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 09:32:42 volumio volumio[987]: info: FusionDsp - Woonkamer Andre v1 Mar 28 09:32:42 volumio volumio[987]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,.json,Woonkamer Andre v1.json Mar 28 09:32:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 28 09:32:43 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 28 09:32:44 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 09:32:44 volumio volumio[987]: info: Received Get System Info Mar 28 09:32:44 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 09:32:44 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 09:32:44 volumio volumio[987]: info: Discovery: Getting this device information Mar 28 09:32:44 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Mar 28 09:32:44 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:44 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 09:32:44 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Mar 28 09:32:44 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 28 09:32:44 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:32:44 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:44 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 28 09:32:44 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:44 volumio volumio[987]: info: [1774686764632] ControllerSpotify::clearAddPlayTrack Mar 28 09:32:44 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 28 09:32:45 volumio go-librespot[1301]: time="2026-03-28T09:32:45+01:00" level=trace msg="sent dealer ping" Mar 28 09:32:45 volumio go-librespot[1301]: time="2026-03-28T09:32:45+01:00" level=trace msg="received dealer pong" Mar 28 09:32:45 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 09:32:45 volumio volumio[987]: info: Received Get System Info Mar 28 09:32:45 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 09:32:45 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 09:32:45 volumio volumio[987]: info: Discovery: Getting this device information Mar 28 09:32:45 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Mar 28 09:32:45 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:45 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 09:32:51 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Mar 28 09:32:51 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 28 09:32:51 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:32:51 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:51 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 28 09:32:51 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:32:51 volumio volumio[987]: info: [1774686771243] ControllerSpotify::clearAddPlayTrack Mar 28 09:32:51 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 28 09:32:52 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 28 09:32:56 volumio volumio[987]: info: Getting Alsa Cards List without I2S DAC Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 28 09:32:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 28 09:33:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 09:33:00 volumio volumio[987]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 28 09:33:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 28 09:33:00 volumio volumio[987]: info: Received Get System Version Mar 28 09:33:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 09:33:00 volumio volumio[987]: info: Received Get System Info Mar 28 09:33:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 09:33:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 09:33:00 volumio volumio[987]: info: Discovery: Getting this device information Mar 28 09:33:00 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Mar 28 09:33:00 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:33:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 09:33:09 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Mar 28 09:33:09 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 28 09:33:09 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:09 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:33:09 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 28 09:33:09 volumio volumio[987]: info: CorePlayQueue::getTrack 27 Mar 28 09:33:09 volumio volumio[987]: info: [1774686789150] ControllerSpotify::clearAddPlayTrack Mar 28 09:33:09 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 28 09:33:11 volumio volumio[987]: info: CoreCommandRouter::volumioGetQueue Mar 28 09:33:11 volumio volumio[987]: info: CoreStateMachine::getQueue Mar 28 09:33:11 volumio volumio[987]: info: CorePlayQueue::getQueue Mar 28 09:33:13 volumio volumio[987]: info: Preload queue cleared Mar 28 09:33:13 volumio volumio[987]: info: Preloading song: spotify:track:4ThbwJaIWVxXZ1qJaHQBCz Mar 28 09:33:13 volumio volumio[987]: info: Preloading song: spotify:track:3t6gUcGYLrUuqwpXjOFWQc Mar 28 09:33:13 volumio volumio[987]: info: Exploding uri spotify:track:4ThbwJaIWVxXZ1qJaHQBCz in service spop Mar 28 09:33:13 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:4ThbwJaIWVxXZ1qJaHQBCz Mar 28 09:33:13 volumio volumio[987]: info: Exploding uri spotify:track:3t6gUcGYLrUuqwpXjOFWQc in service spop Mar 28 09:33:13 volumio volumio[987]: SPOTIFY: EXPLODING URI:spotify:track:3t6gUcGYLrUuqwpXjOFWQc Mar 28 09:33:13 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4ThbwJaIWVxXZ1qJaHQBCz","service":"spop","name":"Travelin' Soldier","artist":"Cody Johnson","album":"Travelin' Soldier","type":"song","duration":255,"albumart":"https://i.scdn.co/image/ab67616d0000b273dd631f0e629677d200d00126","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 28 09:33:13 volumio volumio[987]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3t6gUcGYLrUuqwpXjOFWQc","service":"spop","name":"I Never Lie","artist":"Zach Top","album":"Cold Beer & Country Music","type":"song","duration":224,"albumart":"https://i.scdn.co/image/ab67616d0000b273eff0aba5b84f925e09f70b29","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Mar 28 09:33:14 volumio volumio[987]: info: Preload queue cleared Mar 28 09:33:14 volumio volumio[987]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::ClearQueue Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::stop Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::clearPlayQueue Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 28 09:33:14 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::addQueueItems Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::addQueueItems Mar 28 09:33:14 volumio volumio[987]: info: Preload queue cleared Mar 28 09:33:14 volumio volumio[987]: info: Adding Item to queue: spotify:track:0c25pdkvRhymYdm5Rf3XWh Mar 28 09:33:14 volumio volumio[987]: info: Using cached record of: spotify:track:0c25pdkvRhymYdm5Rf3XWh Mar 28 09:33:14 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 28 09:33:14 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::play index 0 Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::addQueueItems Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::addQueueItems Mar 28 09:33:14 volumio volumio[987]: info: Preload queue cleared Mar 28 09:33:14 volumio volumio[987]: info: Adding Item to queue: spotify:track:4ThbwJaIWVxXZ1qJaHQBCz Mar 28 09:33:14 volumio volumio[987]: info: Using cached record of: spotify:track:4ThbwJaIWVxXZ1qJaHQBCz Mar 28 09:33:14 volumio volumio[987]: info: Adding Item to queue: spotify:track:3t6gUcGYLrUuqwpXjOFWQc Mar 28 09:33:14 volumio volumio[987]: info: Using cached record of: spotify:track:3t6gUcGYLrUuqwpXjOFWQc Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::stop Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:14 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 28 09:33:14 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 28 09:33:14 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 28 09:33:14 volumio volumio[987]: info: [1774686794218] ControllerSpotify::clearAddPlayTrack Mar 28 09:33:14 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 28 09:33:15 volumio go-librespot[1301]: time="2026-03-28T09:33:15+01:00" level=trace msg="sent dealer ping" Mar 28 09:33:15 volumio go-librespot[1301]: time="2026-03-28T09:33:15+01:00" level=trace msg="received dealer pong" Mar 28 09:33:18 volumio volumio[987]: info: Preload queue cleared Mar 28 09:33:18 volumio volumio[987]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::ClearQueue Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::stop Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::clearPlayQueue Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 28 09:33:18 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::addQueueItems Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::addQueueItems Mar 28 09:33:18 volumio volumio[987]: info: Preload queue cleared Mar 28 09:33:18 volumio volumio[987]: info: Adding Item to queue: spotify:track:0c25pdkvRhymYdm5Rf3XWh Mar 28 09:33:18 volumio volumio[987]: info: Using cached record of: spotify:track:0c25pdkvRhymYdm5Rf3XWh Mar 28 09:33:18 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 28 09:33:18 volumio volumio[987]: info: CoreCommandRouter::volumioPlay Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::play index 0 Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::addQueueItems Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::addQueueItems Mar 28 09:33:18 volumio volumio[987]: info: Preload queue cleared Mar 28 09:33:18 volumio volumio[987]: info: Adding Item to queue: spotify:track:4ThbwJaIWVxXZ1qJaHQBCz Mar 28 09:33:18 volumio volumio[987]: info: Using cached record of: spotify:track:4ThbwJaIWVxXZ1qJaHQBCz Mar 28 09:33:18 volumio volumio[987]: info: Adding Item to queue: spotify:track:3t6gUcGYLrUuqwpXjOFWQc Mar 28 09:33:18 volumio volumio[987]: info: Using cached record of: spotify:track:3t6gUcGYLrUuqwpXjOFWQc Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::stop Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:18 volumio volumio[987]: info: CoreCommandRouter::volumioPushQueue Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::saveQueue Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::play index undefined Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 28 09:33:18 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Mar 28 09:33:18 volumio volumio[987]: info: CorePlayQueue::getTrack 0 Mar 28 09:33:18 volumio volumio[987]: info: [1774686798818] ControllerSpotify::clearAddPlayTrack Mar 28 09:33:18 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Mar 28 09:33:26 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 09:33:26 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 28 09:33:26 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 09:33:26 volumio volumio[987]: info: FusionDsp - Woonkamer Andre v1 Mar 28 09:33:26 volumio volumio[987]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,.json,Woonkamer Andre v1.json Mar 28 09:33:36 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 09:33:36 volumio volumio[987]: info: FusionDsp - Woonkamer Andre v1 Mar 28 09:33:36 volumio volumio[987]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,.json,Woonkamer Andre v1.json Mar 28 09:33:40 volumio volumio[987]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Mar 28 09:33:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Mar 28 09:33:40 volumio volumio[987]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 28 09:33:40 volumio volumio[987]: error: FusionDsp - WebSocket error: [object Object] Mar 28 09:33:40 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 09:33:40 volumio volumio[987]: info: CoreCommandRouter::Close All Modals sent Mar 28 09:33:40 volumio volumio[987]: info: FusionDsp - Woonkamer Andre v1 Mar 28 09:33:40 volumio volumio[987]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json,.json,Woonkamer Andre v1.json Mar 28 09:33:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 09:33:42 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 28 09:33:45 volumio go-librespot[1301]: time="2026-03-28T09:33:45+01:00" level=trace msg="received accesspoint ping" Mar 28 09:33:45 volumio go-librespot[1301]: time="2026-03-28T09:33:45+01:00" level=trace msg="received accesspoint pong ack" Mar 28 09:33:45 volumio go-librespot[1301]: time="2026-03-28T09:33:45+01:00" level=trace msg="sent dealer ping" Mar 28 09:33:45 volumio go-librespot[1301]: time="2026-03-28T09:33:45+01:00" level=trace msg="received dealer pong" Mar 28 09:33:47 volumio volumio[987]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Mar 28 09:33:48 volumio volumio5-onboarding[1906]: time=2026-03-28T09:33:48.000+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Mar 28 09:33:49 volumio volumio[987]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Mar 28 09:33:49 volumio volumio[987]: info: FusionDsp - Stopping FusionDsp service Mar 28 09:33:49 volumio volumio[987]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 09:33:49 volumio volumio[987]: TypeError: Cannot read property 'stop' of null Mar 28 09:33:49 volumio volumio[987]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Mar 28 09:33:49 volumio volumio[987]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Mar 28 09:33:49 volumio volumio[987]: at /volumio/app/pluginmanager.js:956:12 Mar 28 09:33:49 volumio volumio[987]: at ChildProcess.exithandler (child_process.js:299:7) Mar 28 09:33:49 volumio volumio[987]: at ChildProcess.emit (events.js:315:20) Mar 28 09:33:49 volumio volumio[987]: at maybeClose (internal/child_process.js:1048:16) Mar 28 09:33:49 volumio volumio[987]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) Mar 28 09:33:49 volumio volumio[987]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 09:33:50 volumio sudo[4409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-28 09:32 Mar 28 09:33:50 volumio sudo[4409]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"