-- Logs begin at Fri 2025-12-12 19:51:01 CET, end at Sat 2025-12-20 20:32:52 CET. -- Dec 20 20:31:26 volumiooo volumio[26173]: verbose: New Socket.io Connection to 192.168.178.75 from 192.168.178.58 UA: Mozilla/5.0 (Android 16; Mobile; rv:146.0) Gecko/146.0 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 6 Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::volumioGetState Dec 20 20:31:26 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 6 Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::volumioGetQueue Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreStateMachine::getQueue Dec 20 20:31:26 volumiooo volumio[26173]: info: CorePlayQueue::getQueue Dec 20 20:31:26 volumiooo volumio[26173]: info: Listing playlists Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 20:31:26 volumiooo volumio[26173]: info: Received Get System Info Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 20:31:26 volumiooo volumio[26173]: info: Discovery: Getting this device information Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::volumioGetState Dec 20 20:31:26 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 6 Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::volumioGetState Dec 20 20:31:26 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 6 Dec 20 20:31:26 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 20 20:31:32 volumiooo wpa_supplicant[955]: RRM: Ignoring radio measurement request: Not RRM network Dec 20 20:31:33 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 20:31:33 volumiooo volumio[26173]: info: CURURI: artists:// Dec 20 20:31:33 volumiooo volumio[26173]: info: Preload queue cleared Dec 20 20:31:34 volumiooo wpa_supplicant[955]: RRM: Ignoring radio measurement request: Not RRM network Dec 20 20:31:46 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 6 Dec 20 20:31:46 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:46 volumiooo volumio[26173]: info: Prefetching next song Dec 20 20:31:46 volumiooo volumio[26173]: info: DOING PREFETCH IN MPD Dec 20 20:31:46 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand add "NAS/alud/Los Lobos/Wolf Tracks - 08 - One time one night.mp3" Dec 20 20:31:46 volumiooo volumio[26173]: info: Dec 20 20:31:46 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:31:46 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:31:46 volumiooo volumio[26173]: info: sendMpdCommand add "NAS/alud/Los Lobos/Wolf Tracks - 08 - One time one night.mp3" took 6 milliseconds Dec 20 20:31:46 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 20 20:31:46 volumiooo volumio[26173]: info: Dec 20 20:31:46 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:31:46 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:31:46 volumiooo volumio[26173]: info: Dec 20 20:31:46 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:31:46 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:31:46 volumiooo volumio[26173]: info: ------------------------------ 7ms Dec 20 20:31:46 volumiooo volumio[26173]: info: sendMpdCommand consume 1 took 4 milliseconds Dec 20 20:31:46 volumiooo volumio[26173]: info: ------------------------------ 3ms Dec 20 20:31:46 volumiooo volumio[26173]: info: ------------------------------ 3ms Dec 20 20:31:50 volumiooo volumio[26173]: info: CoreStateMachine::startPlaybackTimer Dec 20 20:31:50 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:51 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:31:51 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:51 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:31:51 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:31:51 volumiooo volumio[26173]: info: [LastFM] Current track has sufficient metadata: title (One Time One Night) and artist (Los Lobos) passed on explicitly Dec 20 20:31:51 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:31:51 volumiooo volumio[26173]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"One Time One Night","mbid":"1597364e-7985-35fb-97b9-a5625a9fcd87","url":"https://www.last.fm/music/Los+Lobos/_/One+Time+One+Night","duration":"235000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"16000","playcount":"55896","artist":{"name":"Los Lobos","mbid":"2b9967c7-3246-4658-a561-ded5408dd9af","url":"https://www.last.fm/music/Los+Lobos"},"album":{"artist":"Los Lobos","title":"Wolf Tracks: The Best of Los Lobos","url":"https://www.last.fm/music/Los+Lobos/Wolf+Tracks:+The+Best+of+Los+Lobos","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/ab51ec3c12bca5d059756c2fb0d1cc82.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/ab51ec3c12bca5d059756c2fb0d1cc82.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/ab51ec3c12bca5d059756c2fb0d1cc82.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/ab51ec3c12bca5d059756c2fb0d1cc82.png","@":{"size":"extralarge"}}]},"userplaycount":"0","userloved":"0","toptags":""}} Dec 20 20:31:52 volumiooo volumio[26173]: info: Dec 20 20:31:52 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:31:52 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:31:52 volumiooo volumio[26173]: info: Dec 20 20:31:52 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:31:52 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:31:52 volumiooo volumio[26173]: info: Dec 20 20:31:52 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:31:52 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:31:52 volumiooo volumio[26173]: info: Dec 20 20:31:52 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:31:52 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:31:52 volumiooo volumio[26173]: info: Dec 20 20:31:52 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:31:52 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:31:52 volumiooo volumio[26173]: info: Dec 20 20:31:52 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:31:52 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:31:52 volumiooo volumio[26173]: info: ------------------------------ 6ms Dec 20 20:31:52 volumiooo volumio[26173]: info: sendMpdCommand status took 6 milliseconds Dec 20 20:31:52 volumiooo volumio[26173]: info: ------------------------------ 5ms Dec 20 20:31:52 volumiooo volumio[26173]: info: sendMpdCommand status took 5 milliseconds Dec 20 20:31:52 volumiooo volumio[26173]: info: ------------------------------ 5ms Dec 20 20:31:52 volumiooo volumio[26173]: info: sendMpdCommand status took 5 milliseconds Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:31:52 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 20:31:52 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 20:31:52 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:31:52 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:31:52 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":288,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"One Time One Night","artist":"Los Lobos","album":"Wolf Tracks: The Best of Los Lobos","uri":"NAS/alud/Los Lobos/Wolf Tracks - 08 - One time one night.mp3","trackType":"mp3"} Dec 20 20:31:52 volumiooo volumio[26173]: verbose: CURRENT POSITION 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:31:52 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:31:52 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":288,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"One Time One Night","artist":"Los Lobos","album":"Wolf Tracks: The Best of Los Lobos","uri":"NAS/alud/Los Lobos/Wolf Tracks - 08 - One time one night.mp3","trackType":"mp3"} Dec 20 20:31:52 volumiooo volumio[26173]: verbose: CURRENT POSITION 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:31:52 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:31:52 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":288,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"One Time One Night","artist":"Los Lobos","album":"Wolf Tracks: The Best of Los Lobos","uri":"NAS/alud/Los Lobos/Wolf Tracks - 08 - One time one night.mp3","trackType":"mp3"} Dec 20 20:31:52 volumiooo volumio[26173]: verbose: CURRENT POSITION 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:31:52 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:31:52 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:31:52 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:31:52 volumiooo volumio[26173]: info: ------------------------------ 31ms Dec 20 20:31:52 volumiooo volumio[26173]: info: ------------------------------ 30ms Dec 20 20:31:52 volumiooo volumio[26173]: info: ------------------------------ 29ms Dec 20 20:31:52 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:31:52 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:31:52 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:31:52 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:31:52 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:31:52 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: info: Preload queue cleared Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::ClearQueue Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::stop Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::stPlaybackTimer Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::updateTrackBlock Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrackBlock Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::serviceStop Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 7 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::serviceStop Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::stop Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::clearPlayQueue Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::saveQueue Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushQueue Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::addQueueItems Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::addQueueItems Dec 20 20:32:09 volumiooo volumio[26173]: info: Preload queue cleared Dec 20 20:32:09 volumiooo volumio[26173]: info: Adding Item to queue: artists://Mark%20Knopfler%20%26%20Emmylou%20Harris Dec 20 20:32:09 volumiooo volumio[26173]: info: Exploding uri artists://Mark%20Knopfler%20%26%20Emmylou%20Harris in service mpd Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushQueue Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::saveQueue Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::updateTrackBlock Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrackBlock Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPlay Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::play index 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::stop Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::play index undefined Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::startPlaybackTimer Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::clearAddPlayTracks NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand stop took 31 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand stop took 1 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:32:09 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 5 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand clear took 4 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 4 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 3 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand add "NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3" Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService stop Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus stop Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: No code Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService stop Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus stop Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: No code Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 20ms Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 20ms Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:32:09 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:32:09 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:32:09 volumiooo volumio[26173]: error: updateQueue error: null Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:32:09 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 24ms Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand add "NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3" took 22 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 7ms Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 6ms Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand play Dec 20 20:32:09 volumiooo volumio[26173]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 30ms Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:32:09 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces system playlist update Dec 20 20:32:09 volumiooo volumio[26173]: info: Ignoring MPD Status Update Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 15ms Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand play took 14 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 13ms Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 12ms Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 9 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 8 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 7 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Beachcombing","artist":"Mark Knopfler & Emmylou Harris","album":"All the Roadrunning","uri":"NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3","trackType":"mp3"} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus stop Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 13ms Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: Dec 20 20:32:09 volumiooo volumio[26173]: ---------------------------- MPD announces state update: player Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::getState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand status Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 4 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 2 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand status took 1 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseState Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":377,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Beachcombing","artist":"Mark Knopfler & Emmylou Harris","album":"All the Roadrunning","uri":"NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3","trackType":"mp3"} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:32:09 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Beachcombing","artist":"Mark Knopfler & Emmylou Harris","album":"All the Roadrunning","uri":"NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3","trackType":"mp3"} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:32:09 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 27ms Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 27ms Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:32:09 volumiooo volumio[26173]: verbose: ControllerMpd::parseTrackInfo Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Beachcombing","artist":"Mark Knopfler & Emmylou Harris","album":"All the Roadrunning","uri":"NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3","trackType":"mp3"} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:32:09 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Beachcombing","artist":"Mark Knopfler & Emmylou Harris","album":"All the Roadrunning","uri":"NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3","trackType":"mp3"} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:32:09 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: ControllerMpd::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::servicePushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Beachcombing","artist":"Mark Knopfler & Emmylou Harris","album":"All the Roadrunning","uri":"NAS/alud/Mark Knopfler & Emmylou Harris/Beachcombing.mp3","trackType":"mp3"} Dec 20 20:32:09 volumiooo volumio[26173]: verbose: CURRENT POSITION 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState stateService play Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::syncState currentStatus play Dec 20 20:32:09 volumiooo volumio[26173]: info: Received an update from plugin. extracting info from payload Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:09 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:09 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 40ms Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 37ms Dec 20 20:32:09 volumiooo volumio[26173]: info: ------------------------------ 37ms Dec 20 20:32:09 volumiooo volumio[26173]: info: [LastFM] Current track has sufficient metadata: title (Beachcombing) and artist (Mark Knopfler & Emmylou Harris) passed on explicitly Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Dec 20 20:32:09 volumiooo volumio[26173]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"Beachcombing","mbid":"8052f242-df6a-4002-823e-cc0ddbc1ba97","url":"https://www.last.fm/music/Mark+Knopfler+&+Emmylou+Harris/_/Beachcombing","duration":"254000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"15371","playcount":"65933","artist":{"name":"Mark Knopfler & Emmylou Harris","url":"https://www.last.fm/music/Mark+Knopfler+&+Emmylou+Harris"},"album":{"artist":"Mark Knopfler & Emmylou Harris","title":"All The Roadrunning","url":"https://www.last.fm/music/Mark+Knopfler+&+Emmylou+Harris/All+The+Roadrunning","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/bc6d56c9156c5bbca98fa459f15cb701.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/bc6d56c9156c5bbca98fa459f15cb701.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/bc6d56c9156c5bbca98fa459f15cb701.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/bc6d56c9156c5bbca98fa459f15cb701.png","@":{"size":"extralarge"}}]},"userplaycount":"3","userloved":"0","toptags":""}} Dec 20 20:32:22 volumiooo volumio[26173]: info: VolumeController::SetAlsaVolume66 Dec 20 20:32:22 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:22 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:22 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:32:22 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: SPOTIFY VOLUME 67 Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: VOLUMIO VOLUME 66 Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 20 20:32:22 volumiooo volumio[26173]: info: VolumeController::SetAlsaVolume87 Dec 20 20:32:22 volumiooo volumio[26173]: info: CoreStateMachine::pushState Dec 20 20:32:22 volumiooo volumio[26173]: info: CorePlayQueue::getTrack 0 Dec 20 20:32:22 volumiooo volumio[26173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 20:32:22 volumiooo volumio[26173]: info: CoreCommandRouter::volumioPushState Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: RECEIVED VOLUMIO VOLUME 87 Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: SPOTIFY VOLUME 67 Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: VOLUMIO VOLUME 87 Dec 20 20:32:22 volumiooo volumio[26173]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 20 20:32:22 volumiooo volumio[26173]: info: Setting Spotify Volume from Volumio: 87 Dec 20 20:32:23 volumiooo volumio[26173]: SPOTIFY: SETTING SPOTIFY VOLUME 87 Dec 20 20:32:23 volumiooo volumio[26173]: info: Sending Spotify command with payload to local API: /player/volume Dec 20 20:32:23 volumiooo go-librespot[26342]: time="2025-12-20T20:32:23+01:00" level=debug msg="update volume to 57015/65535" Dec 20 20:32:23 volumiooo go-librespot[26342]: time="2025-12-20T20:32:23+01:00" level=debug msg="renewing login5 access token" Dec 20 20:32:23 volumiooo go-librespot[26342]: time="2025-12-20T20:32:23+01:00" level=debug msg="authenticated as sjoukebakker" Dec 20 20:32:24 volumiooo go-librespot[26342]: time="2025-12-20T20:32:24+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 20 20:32:24 volumiooo go-librespot[26342]: time="2025-12-20T20:32:24+01:00" level=trace msg="emitting websocket event: volume" Dec 20 20:32:24 volumiooo volumio[26173]: SPOTIFY: received: {"type":"volume","data":{"value":87,"max":100}} Dec 20 20:32:24 volumiooo volumio[26173]: SPOTIFY: RECEIVED SPOTIFY VOLUME 87 Dec 20 20:32:49 volumiooo nmbd[739]: [2025/12/20 20:32:49.519431, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 20 20:32:49 volumiooo nmbd[739]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.30 for name WORKGROUP<1d>. Dec 20 20:32:49 volumiooo nmbd[739]: This response was from IP 192.168.178.56, reporting an IP address of 192.168.178.56. Dec 20 20:32:49 volumiooo nmbd[739]: [2025/12/20 20:32:49.519854, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 20 20:32:49 volumiooo nmbd[739]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.75 for name WORKGROUP<1d>. Dec 20 20:32:49 volumiooo nmbd[739]: This response was from IP 192.168.178.56, reporting an IP address of 192.168.178.56. Dec 20 20:32:51 volumiooo volumio[26173]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 20:32:51 volumiooo volumio[26173]: TypeError: Cannot read property 'slice' of null Dec 20 20:32:51 volumiooo volumio[26173]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 20 20:32:51 volumiooo volumio[26173]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 20 20:32:51 volumiooo volumio[26173]: at Object.onceWrapper (events.js:422:26) Dec 20 20:32:51 volumiooo volumio[26173]: at ClientRequest.emit (events.js:315:20) Dec 20 20:32:51 volumiooo volumio[26173]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 20 20:32:51 volumiooo volumio[26173]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 20 20:32:51 volumiooo volumio[26173]: at TLSSocket.socketOnData (_http_client.js:509:22) Dec 20 20:32:51 volumiooo volumio[26173]: at TLSSocket.emit (events.js:315:20) Dec 20 20:32:51 volumiooo volumio[26173]: at addChunk (internal/streams/readable.js:309:12) Dec 20 20:32:51 volumiooo volumio[26173]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 20 20:32:51 volumiooo volumio[26173]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Dec 20 20:32:51 volumiooo volumio[26173]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Dec 20 20:32:51 volumiooo volumio[26173]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 20:32:52 volumiooo sudo[31135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-20 20:31 Dec 20 20:32:52 volumiooo sudo[31135]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"