-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2026-03-04 18:47:57 CET. -- Mar 04 18:46:03 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:46:03 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:46:03 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 04 18:46:03 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 04 18:46:03 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 04 18:46:03 volumio volumio[697]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 18:46:03 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 18:46:04 volumio ntpd[779]: Soliciting pool server 206.71.158.74 Mar 04 18:46:05 volumio volumio[697]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 04 18:46:05 volumio volumio[697]: info: Completed starting MyVolumio Plugin Mar 04 18:46:05 volumio volumio[697]: info: BOOT COMPLETED Mar 04 18:46:05 volumio volumio[697]: [Metrics] CommandRouter: 71s 157.67ms Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::volumiosetStartupVolume Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:46:05 volumio volumio[697]: info: VolumeController:: Setting startup Volume 80 Mar 04 18:46:05 volumio volumio[697]: info: VolumeController::SetAlsaVolume80 Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::Close All Modals sent Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::Close All Modals sent Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 04 18:46:05 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 04 18:46:05 volumio volumio[697]: info: CoreStateMachine::pushState Mar 04 18:46:05 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 18:46:05 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 04 18:46:05 volumio volumio[697]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Mar 04 18:46:05 volumio volumio[697]: SPOTIFY: SPOTIFY VOLUME 100 Mar 04 18:46:05 volumio volumio[697]: SPOTIFY: VOLUMIO VOLUME 80 Mar 04 18:46:05 volumio volumio[697]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 04 18:46:05 volumio volumio[697]: info: Setting Spotify Volume from Volumio: 80 Mar 04 18:46:05 volumio ntpd[779]: Soliciting pool server 164.92.156.55 Mar 04 18:46:06 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 04 18:46:06 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 04 18:46:06 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 04 18:46:07 volumio volumio[697]: SPOTIFY: SETTING SPOTIFY VOLUME 80 Mar 04 18:46:07 volumio volumio[697]: info: Sending Spotify command with payload to local API: /player/volume Mar 04 18:46:07 volumio go-librespot[966]: time="2026-03-04T18:46:07+01:00" level=debug msg="update volume requested to 52428/65535" Mar 04 18:46:07 volumio go-librespot[966]: time="2026-03-04T18:46:07+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 04 18:46:07 volumio go-librespot[966]: time="2026-03-04T18:46:07+01:00" level=trace msg="emitting websocket event: volume" Mar 04 18:46:07 volumio volumio[697]: SPOTIFY: received: {"type":"volume","data":{"value":80,"max":100}} Mar 04 18:46:07 volumio volumio[697]: SPOTIFY: RECEIVED SPOTIFY VOLUME 80 Mar 04 18:46:23 volumio go-librespot[966]: time="2026-03-04T18:46:23+01:00" level=trace msg="sent dealer ping" Mar 04 18:46:23 volumio go-librespot[966]: time="2026-03-04T18:46:23+01:00" level=trace msg="received dealer pong" Mar 04 18:46:53 volumio go-librespot[966]: time="2026-03-04T18:46:53+01:00" level=trace msg="sent dealer ping" Mar 04 18:46:53 volumio go-librespot[966]: time="2026-03-04T18:46:53+01:00" level=trace msg="received dealer pong" Mar 04 18:47:09 volumio volumio[697]: verbose: New Socket.io Connection to 192.168.178.47 from 192.168.178.26 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Total Clients: 5 Mar 04 18:47:09 volumio volumio[697]: verbose: New Socket.io Connection to 192.168.178.47 from 192.168.178.26 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Mobile Safari/537.36 Total Clients: 6 Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::volumioGetVisibleSources Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 04 18:47:09 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 04 18:47:09 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 04 18:47:09 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 04 18:47:09 volumio volumio[697]: info: Listing playlists Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 04 18:47:09 volumio volumio[697]: info: Received Get System Info Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:47:09 volumio volumio[697]: info: Discovery: Getting this device information Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 04 18:47:09 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 04 18:47:09 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 04 18:47:09 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 04 18:47:14 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:47:14 volumio volumio[697]: info: CURURI: artists:// Mar 04 18:47:14 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:20 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:47:20 volumio volumio[697]: info: CURURI: music-library Mar 04 18:47:20 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:21 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:47:21 volumio volumio[697]: info: CURURI: music-library/NAS Mar 04 18:47:21 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:47:22 volumio volumio[697]: info: CURURI: music-library/NAS/audio Mar 04 18:47:23 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:23 volumio go-librespot[966]: time="2026-03-04T18:47:23+01:00" level=trace msg="received accesspoint ping" Mar 04 18:47:23 volumio go-librespot[966]: time="2026-03-04T18:47:23+01:00" level=trace msg="received accesspoint pong ack" Mar 04 18:47:23 volumio go-librespot[966]: time="2026-03-04T18:47:23+01:00" level=trace msg="sent dealer ping" Mar 04 18:47:23 volumio go-librespot[966]: time="2026-03-04T18:47:23+01:00" level=trace msg="received dealer pong" Mar 04 18:47:24 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:47:24 volumio volumio[697]: info: CURURI: music-library/NAS/audio/Hardrock Mar 04 18:47:24 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:26 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:47:26 volumio volumio[697]: info: CURURI: music-library/NAS/audio/Hardrock/Iron Maiden Mar 04 18:47:26 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:30 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 18:47:30 volumio volumio[697]: info: CURURI: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz] Mar 04 18:47:30 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/01. Aces High.flac Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/03. Losfer Words (Big 'Orra).flac Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/04. Flash Of The Blade.flac Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/05. The Duellists.flac Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/06. Back In The Village.flac Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/07. Powerslave.flac Mar 04 18:47:30 volumio volumio[697]: info: Preloading song: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/08. Rime Of The Ancient Mariner.flac Mar 04 18:47:30 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/01. Aces High.flac in service mpd Mar 04 18:47:30 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac in service mpd Mar 04 18:47:30 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/03. Losfer Words (Big 'Orra).flac in service mpd Mar 04 18:47:30 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/04. Flash Of The Blade.flac in service mpd Mar 04 18:47:30 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/05. The Duellists.flac in service mpd Mar 04 18:47:30 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F01.%20Aces%20High.flac&metadata=false Mar 04 18:47:30 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/01. Aces High.flac Mar 04 18:47:30 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F02.%202%20Minutes%20To%20Midnight.flac&metadata=false Mar 04 18:47:30 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac Mar 04 18:47:30 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F03.%20Losfer%20Words%20(Big%20'Orra).flac&metadata=false Mar 04 18:47:30 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/03. Losfer Words (Big 'Orra).flac Mar 04 18:47:30 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F04.%20Flash%20Of%20The%20Blade.flac&metadata=false Mar 04 18:47:30 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/04. Flash Of The Blade.flac Mar 04 18:47:30 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F05.%20The%20Duellists.flac&metadata=false Mar 04 18:47:30 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/05. The Duellists.flac Mar 04 18:47:30 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/06. Back In The Village.flac in service mpd Mar 04 18:47:30 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F06.%20Back%20In%20The%20Village.flac&metadata=false Mar 04 18:47:30 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/06. Back In The Village.flac Mar 04 18:47:30 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/07. Powerslave.flac in service mpd Mar 04 18:47:30 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F07.%20Powerslave.flac&metadata=false Mar 04 18:47:30 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/07. Powerslave.flac Mar 04 18:47:31 volumio volumio[697]: info: Exploding uri music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/08. Rime Of The Ancient Mariner.flac in service mpd Mar 04 18:47:31 volumio volumio[697]: info: ALBUMART /albumart?cacheid=923&web=Iron%20Maiden/Powerslave/extralarge&path=%2Fmnt%2FNAS%2Faudio%2FHardrock%2FIron%20Maiden%2F1984%20Powerslave%20%5B24-bit%2096kHz%5D%2F08.%20Rime%20Of%20The%20Ancient%20Mariner.flac&metadata=false Mar 04 18:47:31 volumio volumio[697]: info: URI /mnt/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/08. Rime Of The Ancient Mariner.flac Mar 04 18:47:32 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:32 volumio volumio[697]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::ClearQueue Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::stop Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::clearPlayQueue Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::saveQueue Mar 04 18:47:32 volumio volumio[697]: info: CoreCommandRouter::volumioPushQueue Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::addQueueItems Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::addQueueItems Mar 04 18:47:32 volumio volumio[697]: info: Preload queue cleared Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/01. Aces High.flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/01. Aces High.flac Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/03. Losfer Words (Big 'Orra).flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/03. Losfer Words (Big 'Orra).flac Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/04. Flash Of The Blade.flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/04. Flash Of The Blade.flac Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/05. The Duellists.flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/05. The Duellists.flac Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/06. Back In The Village.flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/06. Back In The Village.flac Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/07. Powerslave.flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/07. Powerslave.flac Mar 04 18:47:32 volumio volumio[697]: info: Adding Item to queue: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/08. Rime Of The Ancient Mariner.flac Mar 04 18:47:32 volumio volumio[697]: info: Using cached record of: music-library/NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/08. Rime Of The Ancient Mariner.flac Mar 04 18:47:32 volumio volumio[697]: info: CoreCommandRouter::volumioPushQueue Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::saveQueue Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::updateTrackBlock Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::getTrackBlock Mar 04 18:47:32 volumio volumio[697]: info: CoreCommandRouter::volumioPlay Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::play index 1 Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::stop Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::play index undefined Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::getTrack 1 Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::startPlaybackTimer Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::getTrack 1 Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::clearAddPlayTracks NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand stop took 12 milliseconds Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand clear Mar 04 18:47:32 volumio volumio[697]: info: Mar 04 18:47:32 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 04 18:47:32 volumio volumio[697]: info: Ignoring MPD Status Update Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand clear took 16 milliseconds Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand add "NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac" Mar 04 18:47:32 volumio volumio[697]: error: updateQueue error: null Mar 04 18:47:32 volumio volumio[697]: info: Mar 04 18:47:32 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 04 18:47:32 volumio volumio[697]: info: Ignoring MPD Status Update Mar 04 18:47:32 volumio volumio[697]: info: ------------------------------ 16ms Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand add "NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac" took 11 milliseconds Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand play Mar 04 18:47:32 volumio volumio[697]: error: Upnp client error: Error: This socket has been ended by the other party Mar 04 18:47:32 volumio volumio[697]: info: ------------------------------ 21ms Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand play took 17 milliseconds Mar 04 18:47:32 volumio volumio[697]: info: Mar 04 18:47:32 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 04 18:47:32 volumio volumio[697]: info: ControllerMpd::getState Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 04 18:47:32 volumio volumio[697]: info: Mar 04 18:47:32 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand status took 6 milliseconds Mar 04 18:47:32 volumio volumio[697]: info: ControllerMpd::getState Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand status took 10 milliseconds Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 18:47:32 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 04 18:47:32 volumio volumio[697]: info: ControllerMpd::pushState Mar 04 18:47:32 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 04 18:47:32 volumio volumio[697]: info: CorePlayQueue::getTrack 1 Mar 04 18:47:32 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":364,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2 Minutes To Midnight","artist":"Iron Maiden","album":"Powerslave","uri":"NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac","trackType":"flac"} Mar 04 18:47:32 volumio volumio[697]: verbose: CURRENT POSITION 1 Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 04 18:47:32 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus stop Mar 04 18:47:32 volumio volumio[697]: info: ------------------------------ 46ms Mar 04 18:47:32 volumio volumio[697]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 04 18:47:33 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 04 18:47:33 volumio volumio[697]: info: ControllerMpd::pushState Mar 04 18:47:33 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 04 18:47:33 volumio volumio[697]: info: CorePlayQueue::getTrack 1 Mar 04 18:47:33 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":364,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2 Minutes To Midnight","artist":"Iron Maiden","album":"Powerslave","uri":"NAS/audio/Hardrock/Iron Maiden/1984 Powerslave [24-bit 96kHz]/02. 2 Minutes To Midnight.flac","trackType":"flac"} Mar 04 18:47:33 volumio volumio[697]: verbose: CURRENT POSITION 1 Mar 04 18:47:33 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 04 18:47:33 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 04 18:47:33 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 04 18:47:33 volumio volumio[697]: info: CoreStateMachine::pushState Mar 04 18:47:33 volumio volumio[697]: info: CorePlayQueue::getTrack 1 Mar 04 18:47:33 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 18:47:33 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 04 18:47:33 volumio volumio[697]: info: CoreStateMachine::pushState Mar 04 18:47:33 volumio volumio[697]: info: CorePlayQueue::getTrack 1 Mar 04 18:47:33 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 04 18:47:33 volumio volumio[697]: info: ------------------------------ 98ms Mar 04 18:47:33 volumio volumio[697]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Mar 04 18:47:33 volumio volumio[697]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Mar 04 18:47:33 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 04 18:47:33 volumio volumio[697]: info: CorePlayQueue::getTrack 1 Mar 04 18:47:53 volumio go-librespot[966]: time="2026-03-04T18:47:53+01:00" level=trace msg="sent dealer ping" Mar 04 18:47:53 volumio go-librespot[966]: time="2026-03-04T18:47:53+01:00" level=trace msg="received dealer pong" Mar 04 18:47:56 volumio volumio[697]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 18:47:56 volumio volumio[697]: TypeError: Cannot read property 'slice' of null Mar 04 18:47:56 volumio volumio[697]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:714:41) Mar 04 18:47:56 volumio volumio[697]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:724:7) Mar 04 18:47:56 volumio volumio[697]: at Object.onceWrapper (events.js:422:26) Mar 04 18:47:56 volumio volumio[697]: at ClientRequest.emit (events.js:315:20) Mar 04 18:47:56 volumio volumio[697]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Mar 04 18:47:56 volumio volumio[697]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Mar 04 18:47:56 volumio volumio[697]: at TLSSocket.socketOnData (_http_client.js:509:22) Mar 04 18:47:56 volumio volumio[697]: at TLSSocket.emit (events.js:315:20) Mar 04 18:47:56 volumio volumio[697]: at addChunk (internal/streams/readable.js:309:12) Mar 04 18:47:56 volumio volumio[697]: at readableAddChunk (internal/streams/readable.js:284:9) Mar 04 18:47:56 volumio volumio[697]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Mar 04 18:47:56 volumio volumio[697]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Mar 04 18:47:56 volumio volumio[697]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 18:47:57 volumio sudo[1155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-04 18:46 Mar 04 18:47:57 volumio sudo[1155]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"