-- Logs begin at Wed 2025-12-10 17:15:54 UTC, end at Wed 2025-12-10 17:59:37 UTC. -- Dec 10 17:58:17 musical-fidelity dhcpcd[7913]: eth0: adding route to 192.168.0.0/24 Dec 10 17:58:17 musical-fidelity dhcpcd[7913]: eth0: adding default route via 192.168.0.1 Dec 10 17:58:17 musical-fidelity dhcpcd[7913]: eth0: removing route to 192.168.0.0/24 Dec 10 17:58:17 musical-fidelity dhcpcd[7913]: eth0: removing default route via 192.168.0.1 Dec 10 17:58:29 musical-fidelity dhcpd[8307]: DHCPDISCOVER from 5c:f3:70:bc:4f:e4 (musical-fidelity) via wlan0 Dec 10 17:58:30 musical-fidelity dhcpd[8307]: DHCPOFFER on 192.168.211.2 to 5c:f3:70:bc:4f:e4 (musical-fidelity) via wlan0 Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 17:58:43 musical-fidelity volumio[1310]: info: Discovery: Getting this device information Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioGetState Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 17:58:43 musical-fidelity volumio[1310]: info: Discovery: Getting this device information Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioGetState Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 10 17:58:43 musical-fidelity volumio[1310]: info: Discovery: Getting this device information Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioGetState Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConf Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 10 17:58:43 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 10 17:58:44 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioGetVisibleSources Dec 10 17:58:44 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 17:58:44 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioGetState Dec 10 17:58:44 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioGetQueue Dec 10 17:58:44 musical-fidelity volumio[1310]: info: CoreStateMachine::getQueue Dec 10 17:58:44 musical-fidelity volumio[1310]: info: CorePlayQueue::getQueue Dec 10 17:58:44 musical-fidelity volumio[1310]: info: Listing playlists Dec 10 17:58:44 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 10 17:58:44 musical-fidelity volumio[1310]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioNext Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:58:46 musical-fidelity volumio[1310]: info: [1765389526799] ControllerTidal::next Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::stop Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:58:46 musical-fidelity volumio[1310]: verbose: UNSET VOLATILE Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::stPlaybackTimer Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::updateTrackBlock Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrackBlock Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 20 Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::serviceStop Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 20 Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreCommandRouter::serviceStop Dec 10 17:58:46 musical-fidelity volumio[1310]: info: [1765389526813] ControllerTidal::stop Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 17:58:46 musical-fidelity volumio[1310]: info: ControllerMpd::stop Dec 10 17:58:46 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 17:58:46 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:58:46 musical-fidelity volumio[1310]: info: Dec 10 17:58:46 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:58:46 musical-fidelity volumio[1310]: info: sendMpdCommand stop took 48 milliseconds Dec 10 17:58:46 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:58:46 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::play index undefined Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::startPlaybackTimer Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:58:46 musical-fidelity volumio[1310]: info: [1765389526865] ControllerTidal::clearAddPlayTrack Dec 10 17:58:46 musical-fidelity volumio[1310]: info: Getting stream with soundQuality HI_RES Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::updateTrackBlock Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrackBlock Dec 10 17:58:46 musical-fidelity volumio[1310]: info: sendMpdCommand status took 22 milliseconds Dec 10 17:58:46 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:58:46 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:58:46 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 10 17:58:46 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:58:46 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:58:46 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:58:46 musical-fidelity volumio[1310]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 10 17:58:46 musical-fidelity volumio[1310]: info: ------------------------------ 43ms Dec 10 17:58:46 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:58:47 musical-fidelity volumio[1310]: info: getStreamUrl took 350 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand stop took 1 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Dec 10 17:58:47 musical-fidelity volumio[1310]: ---------------------------- MPD announces system playlist update Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Ignoring MPD Status Update Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand clear took 2 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidkNTQzMGJmMjM5ZDI3MzhhOTJhOTExMGNhYmIzNmI1OF82MS5tcDQ/0.flac?token=1765393127~NGE5Y2E3YzkwYmJlZTAwOTk3Njg3ZTIzODQwNDcyOTRkZmFhZGJjZg==" Dec 10 17:58:47 musical-fidelity volumio[1310]: error: updateQueue error: null Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Dec 10 17:58:47 musical-fidelity volumio[1310]: ---------------------------- MPD announces system playlist update Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Ignoring MPD Status Update Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ------------------------------ 4ms Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidkNTQzMGJmMjM5ZDI3MzhhOTJhOTExMGNhYmIzNmI1OF82MS5tcDQ/0.flac?token=1765393127~NGE5Y2E3YzkwYmJlZTAwOTk3Njg3ZTIzODQwNDcyOTRkZmFhZGJjZg==" took 3 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand play Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ------------------------------ 3ms Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand play took 3 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Dec 10 17:58:47 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Dec 10 17:58:47 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand status took 13 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand status took 6 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":341,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"589 Kbps","isStreaming":false,"title":"0.flac?token=1765393127~NGE5Y2E3YzkwYmJlZTAwOTk3Njg3ZTIzODQwNDcyOTRkZmFhZGJjZg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidkNTQzMGJmMjM5ZDI3MzhhOTJhOTExMGNhYmIzNmI1OF82MS5tcDQ/0.flac?token=1765393127~NGE5Y2E3YzkwYmJlZTAwOTk3Njg3ZTIzODQwNDcyOTRkZmFhZGJjZg==","trackType":"tidal"} Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: CURRENT POSITION 21 Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState stateService play Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState currentStatus stop Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ------------------------------ 50ms Dec 10 17:58:47 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 32 milliseconds Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":341,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"546 Kbps","isStreaming":false,"title":"0.flac?token=1765393127~NGE5Y2E3YzkwYmJlZTAwOTk3Njg3ZTIzODQwNDcyOTRkZmFhZGJjZg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidkNTQzMGJmMjM5ZDI3MzhhOTJhOTExMGNhYmIzNmI1OF82MS5tcDQ/0.flac?token=1765393127~NGE5Y2E3YzkwYmJlZTAwOTk3Njg3ZTIzODQwNDcyOTRkZmFhZGJjZg==","trackType":"tidal"} Dec 10 17:58:47 musical-fidelity volumio[1310]: verbose: CURRENT POSITION 21 Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState stateService play Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState currentStatus play Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Received an update from plugin. extracting info from payload Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:58:47 musical-fidelity volumio[1310]: info: ------------------------------ 108ms Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Updating push state because input changed Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Updating push state because input changed Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 10 17:58:47 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:58:47 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioNext Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:59:01 musical-fidelity volumio[1310]: info: [1765389541479] ControllerTidal::next Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::stop Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: UNSET VOLATILE Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::stPlaybackTimer Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::updateTrackBlock Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrackBlock Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::serviceStop Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 21 Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreCommandRouter::serviceStop Dec 10 17:59:01 musical-fidelity volumio[1310]: info: [1765389541493] ControllerTidal::stop Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 17:59:01 musical-fidelity volumio[1310]: info: ControllerMpd::stop Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:01 musical-fidelity volumio[1310]: info: sendMpdCommand stop took 41 milliseconds Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::play index undefined Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::startPlaybackTimer Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:01 musical-fidelity volumio[1310]: info: [1765389541539] ControllerTidal::clearAddPlayTrack Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Getting stream with soundQuality HI_RES Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::updateTrackBlock Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrackBlock Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Dec 10 17:59:01 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:59:01 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:59:01 musical-fidelity volumio[1310]: info: sendMpdCommand status took 5 milliseconds Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:59:01 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:59:01 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 10 17:59:01 musical-fidelity volumio[1310]: info: ------------------------------ 18ms Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:01 musical-fidelity volumio[1310]: info: getStreamUrl took 366 milliseconds Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 17:59:01 musical-fidelity volumio[1310]: info: sendMpdCommand stop took 2 milliseconds Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Dec 10 17:59:01 musical-fidelity volumio[1310]: ---------------------------- MPD announces system playlist update Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Ignoring MPD Status Update Dec 10 17:59:01 musical-fidelity volumio[1310]: info: sendMpdCommand clear took 2 milliseconds Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKAgDEiRjYTQ1Njc1NjgxODY5ODQ5NmJmZTkyZmRhODZlODgwZi5tcDQ/0.flac?token=1765393141~YTgzMzIwNDFkYjE4MTMzZTA0OWE1YmRmMDcwNTMxZTA4NWU0YmY3Zg==" Dec 10 17:59:01 musical-fidelity volumio[1310]: error: updateQueue error: null Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Dec 10 17:59:01 musical-fidelity volumio[1310]: ---------------------------- MPD announces system playlist update Dec 10 17:59:01 musical-fidelity volumio[1310]: info: Ignoring MPD Status Update Dec 10 17:59:01 musical-fidelity volumio[1310]: info: ------------------------------ 4ms Dec 10 17:59:01 musical-fidelity volumio[1310]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKAgDEiRjYTQ1Njc1NjgxODY5ODQ5NmJmZTkyZmRhODZlODgwZi5tcDQ/0.flac?token=1765393141~YTgzMzIwNDFkYjE4MTMzZTA0OWE1YmRmMDcwNTMxZTA4NWU0YmY3Zg==" took 3 milliseconds Dec 10 17:59:01 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 17:59:01 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand play Dec 10 17:59:01 musical-fidelity volumio[1310]: info: ------------------------------ 3ms Dec 10 17:59:01 musical-fidelity volumio[1310]: info: sendMpdCommand play took 2 milliseconds Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Dec 10 17:59:02 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:59:02 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Dec 10 17:59:02 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:59:02 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:59:02 musical-fidelity volumio[1310]: info: sendMpdCommand status took 13 milliseconds Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:59:02 musical-fidelity volumio[1310]: info: sendMpdCommand status took 9 milliseconds Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:59:02 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 10 17:59:02 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:59:02 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: STATE SERVICE {"status":"play","position":0,"seek":92,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"672 Kbps","isStreaming":false,"title":"0.flac?token=1765393141~YTgzMzIwNDFkYjE4MTMzZTA0OWE1YmRmMDcwNTMxZTA4NWU0YmY3Zg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKAgDEiRjYTQ1Njc1NjgxODY5ODQ5NmJmZTkyZmRhODZlODgwZi5tcDQ/0.flac?token=1765393141~YTgzMzIwNDFkYjE4MTMzZTA0OWE1YmRmMDcwNTMxZTA4NWU0YmY3Zg==","trackType":"tidal"} Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: CURRENT POSITION 22 Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState stateService play Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState currentStatus stop Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:02 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"557 Kbps","isStreaming":false,"title":"0.flac?token=1765393141~YTgzMzIwNDFkYjE4MTMzZTA0OWE1YmRmMDcwNTMxZTA4NWU0YmY3Zg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKAgDEiRjYTQ1Njc1NjgxODY5ODQ5NmJmZTkyZmRhODZlODgwZi5tcDQ/0.flac?token=1765393141~YTgzMzIwNDFkYjE4MTMzZTA0OWE1YmRmMDcwNTMxZTA4NWU0YmY3Zg==","trackType":"tidal"} Dec 10 17:59:02 musical-fidelity volumio[1310]: verbose: CURRENT POSITION 22 Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState stateService play Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState currentStatus play Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Received an update from plugin. extracting info from payload Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:02 musical-fidelity volumio[1310]: info: ------------------------------ 100ms Dec 10 17:59:02 musical-fidelity volumio[1310]: info: ------------------------------ 94ms Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Updating push state because input changed Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Updating push state because input changed Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 10 17:59:02 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:02 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioNext Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:59:28 musical-fidelity volumio[1310]: info: [1765389568232] ControllerTidal::next Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::stop Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: UNSET VOLATILE Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::stPlaybackTimer Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::updateTrackBlock Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrackBlock Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::serviceStop Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 22 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::serviceStop Dec 10 17:59:28 musical-fidelity volumio[1310]: info: [1765389568237] ControllerTidal::stop Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ControllerMpd::stop Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand stop took 30 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::play index undefined Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::startPlaybackTimer Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: [1765389568270] ControllerTidal::clearAddPlayTrack Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Getting stream with soundQuality HI_RES Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::updateTrackBlock Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrackBlock Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Dec 10 17:59:28 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand status took 6 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ------------------------------ 23ms Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:28 musical-fidelity volumio[1310]: info: getStreamUrl took 303 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand stop took 2 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Dec 10 17:59:28 musical-fidelity volumio[1310]: ---------------------------- MPD announces system playlist update Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Ignoring MPD Status Update Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand clear took 2 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyYzg3ZTEyNzk0Njc1NjFjYTIxNDRhYTY1MjU4YjQ4NV82MS5tcDQ/0.flac?token=1765393168~MTk2NTVhMDJkMzBkZjdkN2MxMjgwNmZiNWQ4NDQyZTUzYzliZDA2NQ==" Dec 10 17:59:28 musical-fidelity volumio[1310]: error: updateQueue error: null Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Dec 10 17:59:28 musical-fidelity volumio[1310]: ---------------------------- MPD announces system playlist update Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Ignoring MPD Status Update Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ------------------------------ 3ms Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyYzg3ZTEyNzk0Njc1NjFjYTIxNDRhYTY1MjU4YjQ4NV82MS5tcDQ/0.flac?token=1765393168~MTk2NTVhMDJkMzBkZjdkN2MxMjgwNmZiNWQ4NDQyZTUzYzliZDA2NQ==" took 2 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand play Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ------------------------------ 5ms Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand play took 3 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Dec 10 17:59:28 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Dec 10 17:59:28 musical-fidelity volumio[1310]: ---------------------------- MPD announces state update: player Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand status took 4 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ControllerMpd::getState Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand status Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand status took 2 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseState Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1765393168~MTk2NTVhMDJkMzBkZjdkN2MxMjgwNmZiNWQ4NDQyZTUzYzliZDA2NQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyYzg3ZTEyNzk0Njc1NjFjYTIxNDRhYTY1MjU4YjQ4NV82MS5tcDQ/0.flac?token=1765393168~MTk2NTVhMDJkMzBkZjdkN2MxMjgwNmZiNWQ4NDQyZTUzYzliZDA2NQ==","trackType":"tidal"} Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: CURRENT POSITION 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState stateService play Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState currentStatus stop Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ------------------------------ 26ms Dec 10 17:59:28 musical-fidelity volumio[1310]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: ControllerMpd::parseTrackInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ControllerMpd::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::servicePushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"613 Kbps","isStreaming":false,"title":"0.flac?token=1765393168~MTk2NTVhMDJkMzBkZjdkN2MxMjgwNmZiNWQ4NDQyZTUzYzliZDA2NQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyYzg3ZTEyNzk0Njc1NjFjYTIxNDRhYTY1MjU4YjQ4NV82MS5tcDQ/0.flac?token=1765393168~MTk2NTVhMDJkMzBkZjdkN2MxMjgwNmZiNWQ4NDQyZTUzYzliZDA2NQ==","trackType":"tidal"} Dec 10 17:59:28 musical-fidelity volumio[1310]: verbose: CURRENT POSITION 0 Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState stateService play Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::syncState currentStatus play Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Received an update from plugin. extracting info from payload Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:28 musical-fidelity volumio[1310]: info: ------------------------------ 58ms Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Updating push state because input changed Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Updating push state because input changed Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 10 17:59:28 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:28 musical-fidelity volumio[1310]: info: Updating RAAT Signal Path Dec 10 17:59:34 musical-fidelity dhcpd[8307]: DHCPDISCOVER from 5c:f3:70:bc:4f:e4 (musical-fidelity) via wlan0 Dec 10 17:59:35 musical-fidelity dhcpd[8307]: DHCPOFFER on 192.168.211.2 to 5c:f3:70:bc:4f:e4 (musical-fidelity) via wlan0 Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioNext Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:59:36 musical-fidelity volumio[1310]: info: [1765389576193] ControllerTidal::next Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::next Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::stop Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 17:59:36 musical-fidelity volumio[1310]: verbose: UNSET VOLATILE Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::stPlaybackTimer Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::updateTrackBlock Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrackBlock Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::pushState Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreCommandRouter::volumioPushState Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::serviceStop Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CorePlayQueue::getTrack 0 Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreCommandRouter::serviceStop Dec 10 17:59:36 musical-fidelity volumio[1310]: info: [1765389576207] ControllerTidal::stop Dec 10 17:59:36 musical-fidelity volumio[1310]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 10 17:59:36 musical-fidelity volumio[1310]: info: ControllerMpd::stop Dec 10 17:59:36 musical-fidelity volumio[1310]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 17:59:36 musical-fidelity systemd-journal[20287]: Runtime journal is using 12.0M (max allowed 30.0M, trying to leave 70.4M free of 456.9M available → current limit 30.0M). Dec 10 17:59:36 musical-fidelity kernel: Unable to handle kernel NULL pointer dereference at virtual address 00000023 Dec 10 17:59:36 musical-fidelity kernel: pgd = b9274000 Dec 10 17:59:36 musical-fidelity kernel: [00000023] *pgd=00000000 Dec 10 17:59:36 musical-fidelity kernel: Internal error: Oops: 5 [#1] SMP ARM Dec 10 17:59:36 musical-fidelity kernel: Modules linked in: bnep xt_REDIRECT nf_nat_redirect xt_tcpudp iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack ip_tables x_tables nfsd 8723bu(O) snd_usb_audio cfg80211 snd_hwdep snd_usbmidi_lib snd_seq_midi snd_seq_midi_event snd_rawmidi btusb(O) btrtl(O) snd_pcm btintel(O) btbcm(O) bluetooth snd_seq snd_seq_device snd_timer evdev joydev rfkill snd bcm2835_gpiomem uio_pdrv_genirq fixed uio i2c_dev ipv6 fuse squashfs overlay Dec 10 17:59:36 musical-fidelity kernel: CPU: 0 PID: 199 Comm: systemd-journal Tainted: G O 4.9.65-v7+ #1 Dec 10 17:59:36 musical-fidelity kernel: Hardware name: BCM2835 Dec 10 17:59:36 musical-fidelity kernel: task: bab06740 task.stack: aebd4000 Dec 10 17:59:36 musical-fidelity kernel: PC is at skb_release_data+0x64/0x128 Dec 10 17:59:36 musical-fidelity kernel: LR is at skb_release_all+0x30/0x34 Dec 10 17:59:36 musical-fidelity kernel: pc : [<805fff80>] lr : [<80600074>] psr: 60000013 sp : aebd5d78 ip : aebd5d98 fp : aebd5d94 Dec 10 17:59:36 musical-fidelity kernel: r10: b9239200 r9 : 00000000 r8 : 00000000 Dec 10 17:59:36 musical-fidelity kernel: r7 : 00000023 r6 : b5a74b40 r5 : b5a74b40 r4 : b5a74b40 Dec 10 17:59:36 musical-fidelity kernel: r3 : 00000000 r2 : 00000001 r1 : 00000000 r0 : b5a74b40 Dec 10 17:59:36 musical-fidelity kernel: Flags: nZCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user Dec 10 17:59:36 musical-fidelity kernel: Control: 10c5383d Table: 3927406a DAC: 00000055 Dec 10 17:59:36 musical-fidelity kernel: Process systemd-journal (pid: 199, stack limit = 0xaebd4210) Dec 10 17:59:36 musical-fidelity kernel: Stack: (0xaebd5d78 to 0xaebd6000) Dec 10 17:59:36 musical-fidelity kernel: 5d60: b5a74b40 b5a74b40 Dec 10 17:59:36 musical-fidelity kernel: 5d80: aebd5e5c 000007df aebd5dac aebd5d98 80600074 805fff28 00000001 b5a74b40 Dec 10 17:59:36 musical-fidelity kernel: 5da0: aebd5dc4 aebd5db0 806001f8 80600050 b5a74b40 00000021 aebd5e54 aebd5dc8 Dec 10 17:59:36 musical-fidelity kernel: 5dc0: 806c2264 806001cc 00000000 00000000 b9239344 00000001 00000000 00000001 Dec 10 17:59:36 musical-fidelity kernel: 5de0: b923940c 00000000 b923944c b506f500 00000021 00000001 00000021 b9239284 Dec 10 17:59:36 musical-fidelity kernel: 5e00: b7bc6480 00000000 0000051e 000003e8 000003e8 b4d98828 aebd5e48 8028727c Dec 10 17:59:36 musical-fidelity kernel: 5e20: 6939b508 0ce4a377 aebd5e6c 00000000 aebd5f00 aebd5ee8 aebd5f78 00000800 Dec 10 17:59:36 musical-fidelity kernel: 5e40: 0243ebb9 00000000 aebd5e84 aebd5e58 806c2410 806c1b10 806bdb84 806be394 Dec 10 17:59:36 musical-fidelity kernel: 5e60: b506f500 aebd5e88 00000000 00000800 00000040 00000000 aebd5ed4 aebd5e88 Dec 10 17:59:36 musical-fidelity kernel: 5e80: 805f71e0 806c23d4 00000000 00000000 00000000 00000021 000007df aebd5ee0 Dec 10 17:59:36 musical-fidelity kernel: 5ea0: 00000001 805c88c0 00000000 00000000 00000040 aebd5f00 aea7cdac 00000000 Dec 10 17:59:36 musical-fidelity kernel: 5ec0: 00000000 b7988300 aebd5f44 aebd5ed8 80268b64 805f7150 00000800 0000001e Dec 10 17:59:36 musical-fidelity kernel: 5ee0: 0243ebb9 00000800 00000000 00000000 00000800 aebd5ee0 00000001 805c88c0 Dec 10 17:59:36 musical-fidelity kernel: 5f00: b7988300 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Dec 10 17:59:36 musical-fidelity kernel: 5f20: 8017ea84 00000800 b7988300 0243ebb9 aebd5f78 00000800 aebd5f74 aebd5f48 Dec 10 17:59:36 musical-fidelity kernel: 5f40: 8026996c 80268aa0 0000025b 80289034 aebd5f74 00000000 00000000 b7988300 Dec 10 17:59:36 musical-fidelity kernel: 5f60: b7988300 00000800 aebd5fa4 aebd5f78 8026ab28 802698e0 00000000 00000000 Dec 10 17:59:36 musical-fidelity kernel: 5f80: 0243eb90 76f0bf10 7ef78728 00000003 80107fa4 aebd4000 00000000 aebd5fa8 Dec 10 17:59:36 musical-fidelity kernel: 5fa0: 80107e20 8026aae8 0243eb90 76f0bf10 00000011 0243ebb9 00000800 00000011 Dec 10 17:59:36 musical-fidelity kernel: 5fc0: 0243eb90 76f0bf10 7ef78728 00000003 76f0bf10 024360a0 02436088 7ef78a1c Dec 10 17:59:36 musical-fidelity kernel: 5fe0: 00000000 7ef78704 004b2e78 76ec2c8c 60000010 00000011 e7fddef0 e7fddef0 Dec 10 17:59:36 musical-fidelity kernel: [<805fff80>] (skb_release_data) from [<80600074>] (skb_release_all+0x30/0x34) Dec 10 17:59:36 musical-fidelity kernel: [<80600074>] (skb_release_all) from [<806001f8>] (consume_skb+0x38/0xe4) Dec 10 17:59:36 musical-fidelity kernel: [<806001f8>] (consume_skb) from [<806c2264>] (unix_stream_read_generic+0x760/0x834) Dec 10 17:59:36 musical-fidelity kernel: [<806c2264>] (unix_stream_read_generic) from [<806c2410>] (unix_stream_recvmsg+0x48/0x54) Dec 10 17:59:36 musical-fidelity kernel: [<806c2410>] (unix_stream_recvmsg) from [<805f71e0>] (sock_read_iter+0x9c/0xd0) Dec 10 17:59:36 musical-fidelity kernel: [<805f71e0>] (sock_read_iter) from [<80268b64>] (__vfs_read+0xd0/0x120) Dec 10 17:59:36 musical-fidelity kernel: [<80268b64>] (__vfs_read) from [<8026996c>] (vfs_read+0x98/0x16c) Dec 10 17:59:36 musical-fidelity kernel: [<8026996c>] (vfs_read) from [<8026ab28>] (SyS_read+0x4c/0xa0) Dec 10 17:59:36 musical-fidelity kernel: [<8026ab28>] (SyS_read) from [<80107e20>] (ret_fast_syscall+0x0/0x1c) Dec 10 17:59:36 musical-fidelity kernel: Code: 1afffffa f57ff05b e3510000 189da8f0 (e5d73000) Dec 10 17:59:36 musical-fidelity kernel: ---[ end trace 4464126919742b0b ]--- Dec 10 17:59:36 musical-fidelity systemd[1]: systemd-journald.service has no holdoff time, scheduling restart. Dec 10 17:59:36 musical-fidelity systemd[1]: Stopping Journal Service... Dec 10 17:59:36 musical-fidelity systemd[1]: Starting Journal Service... Dec 10 17:59:36 musical-fidelity systemd[1]: Started Journal Service. Dec 10 17:59:36 musical-fidelity systemd-journal[20287]: Journal started Dec 10 17:59:36 musical-fidelity systemd[1]: systemd-journald.service: main process exited, code=killed, status=11/SEGV Dec 10 17:59:36 musical-fidelity systemd[1]: Unit systemd-journald.service entered failed state. Dec 10 17:59:36 musical-fidelity systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Dec 10 17:59:36 musical-fidelity systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Dec 10 17:59:37 musical-fidelity sudo[20303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-10 17:58 Dec 10 17:59:37 musical-fidelity sudo[20303]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"