-- Logs begin at Sun 2025-02-23 08:38:29 UTC, end at Sun 2025-02-23 09:04:13 UTC. -- Feb 23 09:03:00 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 23 09:03:00 volumio volumio[834]: info: CURURI: music-library/INTERNAL/Dead Can Dance [SACD BOX] CDDA Layer/Into The Labyrinth (WPCB-10076 - SAD 2711 CD) Feb 23 09:03:03 volumio volumio[834]: info: Feb 23 09:03:03 volumio volumio[834]: [1740301383655] ---------------------------- Client requests add and Play Volumio CUE entry Feb 23 09:03:03 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Feb 23 09:03:03 volumio volumio[834]: info: Adding CUE individual entry: 7 INTERNAL/Dead Can Dance [SACD BOX] CDDA Layer/Into The Labyrinth (WPCB-10076 - SAD 2711 CD)/Dead Can Dance - Into The Labyrinth [SACD BOX] CDDA Layer.cue Feb 23 09:03:03 volumio volumio[834]: info: CoreCommandRouter::volumioAddQueueItems Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::addQueueItems Feb 23 09:03:03 volumio volumio[834]: info: CorePlayQueue::addQueueItems Feb 23 09:03:03 volumio volumio[834]: info: Adding Item to queue: cue://INTERNAL/Dead Can Dance [SACD BOX] CDDA Layer/Into The Labyrinth (WPCB-10076 - SAD 2711 CD)/Dead Can Dance - Into The Labyrinth [SACD BOX] CDDA Layer.cue@7 Feb 23 09:03:03 volumio volumio[834]: info: Exploding uri cue://INTERNAL/Dead Can Dance [SACD BOX] CDDA Layer/Into The Labyrinth (WPCB-10076 - SAD 2711 CD)/Dead Can Dance - Into The Labyrinth [SACD BOX] CDDA Layer.cue@7 in service mpd Feb 23 09:03:03 volumio volumio[834]: info: CoreCommandRouter::volumioPlay Feb 23 09:03:03 volumio volumio[834]: UNSET VOLATILE Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::play index 48813 Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::stop Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 09:03:03 volumio volumio[834]: UNSET VOLATILE Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::stPlaybackTimer Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::updateTrackBlock Feb 23 09:03:03 volumio volumio[834]: info: CorePlayQueue::getTrackBlock Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:03 volumio volumio[834]: info: CorePlayQueue::getTrack 48812 Feb 23 09:03:03 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:03 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:03 volumio volumio[834]: info: CoreStateMachine::serviceStop Feb 23 09:03:03 volumio volumio[834]: info: CorePlayQueue::getTrack 48812 Feb 23 09:03:03 volumio volumio[834]: info: CoreCommandRouter::serviceStop Feb 23 09:03:03 volumio volumio[834]: info: ControllerMpd::stop Feb 23 09:03:03 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 09:03:03 volumio volumio[834]: info: CorePlayQueue::saveQueue Feb 23 09:03:04 volumio volumio[834]: info: CoreCommandRouter::volumioPushQueue Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::updateTrackBlock Feb 23 09:03:07 volumio volumio[834]: info: CorePlayQueue::getTrackBlock Feb 23 09:03:07 volumio volumio[834]: info: Feb 23 09:03:07 volumio volumio[834]: ---------------------------- MPD announces state update: player Feb 23 09:03:07 volumio volumio[834]: info: ControllerMpd::getState Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::play index undefined Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 09:03:07 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::startPlaybackTimer Feb 23 09:03:07 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::parseState Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 09:03:07 volumio volumio[834]: info: Feb 23 09:03:07 volumio volumio[834]: ---------------------------- MPD announces system playlist update Feb 23 09:03:07 volumio volumio[834]: info: Ignoring MPD Status Update Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand load "INTERNAL/Dead Can Dance [SACD BOX] CDDA Layer/Into The Labyrinth (WPCB-10076 - SAD 2711 CD)/Dead Can Dance - Into The Labyrinth [SACD BOX] CDDA Layer.cue" Feb 23 09:03:07 volumio volumio[834]: info: ControllerMpd::pushState Feb 23 09:03:07 volumio volumio[834]: info: CoreCommandRouter::servicePushState Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:07 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:07 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:07 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:07 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:07 volumio volumio[834]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"OPUS3 - TEST CD4.ape","artist":null,"album":null,"uri":"INTERNAL/OPUS3 - TEST CD4 (1992) (XRCD)/OPUS3 - TEST CD4.ape","trackType":"ape"} Feb 23 09:03:07 volumio volumio[834]: verbose: CURRENT POSITION 48813 Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::syncState stateService stop Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus stop Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:07 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:07 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:07 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:07 volumio volumio[834]: info: No code Feb 23 09:03:07 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:07 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:07 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:07 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:07 volumio volumio[834]: info: ------------------------------ 118ms Feb 23 09:03:07 volumio volumio[834]: error: updateQueue error: null Feb 23 09:03:07 volumio volumio[834]: info: Feb 23 09:03:07 volumio volumio[834]: ---------------------------- MPD announces system playlist update Feb 23 09:03:07 volumio volumio[834]: info: Ignoring MPD Status Update Feb 23 09:03:07 volumio volumio[834]: info: ------------------------------ 52ms Feb 23 09:03:07 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand play Feb 23 09:03:07 volumio volumio[834]: info: ------------------------------ 10ms Feb 23 09:03:08 volumio volumio[834]: info: Feb 23 09:03:08 volumio volumio[834]: ---------------------------- MPD announces state update: player Feb 23 09:03:08 volumio volumio[834]: info: ControllerMpd::getState Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status Feb 23 09:03:08 volumio volumio[834]: info: Feb 23 09:03:08 volumio volumio[834]: ---------------------------- MPD announces state update: player Feb 23 09:03:08 volumio volumio[834]: info: ControllerMpd::getState Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::parseState Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::parseState Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo Feb 23 09:03:08 volumio volumio[834]: info: ControllerMpd::pushState Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Feb 23 09:03:08 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:08 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":7,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bird","artist":"Dead Can Dance","album":"Into The Labyrinth [SACD BOX] CDDA Layer","uri":"INTERNAL/Dead Can Dance [SACD BOX] CDDA Layer/Into The Labyrinth (WPCB-10076 - SAD 2711 CD)/Dead Can Dance - Into The Labyrinth [SACD BOX] CDDA Layer.flac","trackType":"flac"} Feb 23 09:03:08 volumio volumio[834]: verbose: CURRENT POSITION 48813 Feb 23 09:03:08 volumio volumio[834]: info: CoreStateMachine::syncState stateService play Feb 23 09:03:08 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus stop Feb 23 09:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:08 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:08 volumio volumio[834]: info: ------------------------------ 28ms Feb 23 09:03:08 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo Feb 23 09:03:08 volumio volumio[834]: info: ControllerMpd::pushState Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::servicePushState Feb 23 09:03:08 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:08 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":7,"seek":464,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"577 Kbps","isStreaming":false,"title":"Bird","artist":"Dead Can Dance","album":"Into The Labyrinth [SACD BOX] CDDA Layer","uri":"INTERNAL/Dead Can Dance [SACD BOX] CDDA Layer/Into The Labyrinth (WPCB-10076 - SAD 2711 CD)/Dead Can Dance - Into The Labyrinth [SACD BOX] CDDA Layer.flac","trackType":"flac"} Feb 23 09:03:08 volumio volumio[834]: verbose: CURRENT POSITION 48813 Feb 23 09:03:08 volumio volumio[834]: info: CoreStateMachine::syncState stateService play Feb 23 09:03:08 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play Feb 23 09:03:08 volumio volumio[834]: info: Received an update from plugin. extracting info from payload Feb 23 09:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:08 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:08 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:08 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:08 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:08 volumio volumio[834]: info: ------------------------------ 50ms Feb 23 09:03:46 volumio volumio[834]: info: VolumeController::SetAlsaVolume- Feb 23 09:03:46 volumio volumio[834]: Unable to parse: Feb 23 09:03:46 volumio volumio[834]: Simple mixer control 'SoftMaster',0 Feb 23 09:03:46 volumio volumio[834]: Capabilities: volume Feb 23 09:03:46 volumio volumio[834]: Playback channels: Front Left - Front Right Feb 23 09:03:46 volumio volumio[834]: Capture channels: Front Left - Front Right Feb 23 09:03:46 volumio volumio[834]: Limits: 0 - 99 Feb 23 09:03:46 volumio volumio[834]: Front Left: 99 [100%] Feb 23 09:03:46 volumio volumio[834]: Front Right: 99 [100%] Feb 23 09:03:46 volumio volumio[834]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 23 09:03:46 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:46 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:46 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:46 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:46 volumio volumio[834]: info: VolumeController::SetAlsaVolume- Feb 23 09:03:46 volumio volumio[834]: Unable to parse: Feb 23 09:03:46 volumio volumio[834]: Simple mixer control 'SoftMaster',0 Feb 23 09:03:46 volumio volumio[834]: Capabilities: volume Feb 23 09:03:46 volumio volumio[834]: Playback channels: Front Left - Front Right Feb 23 09:03:46 volumio volumio[834]: Capture channels: Front Left - Front Right Feb 23 09:03:46 volumio volumio[834]: Limits: 0 - 99 Feb 23 09:03:46 volumio volumio[834]: Front Left: 94 [95%] Feb 23 09:03:46 volumio volumio[834]: Front Right: 94 [95%] Feb 23 09:03:46 volumio volumio[834]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 23 09:03:46 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:46 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:46 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:46 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:46 volumio volumio[834]: info: VolumeController::SetAlsaVolume- Feb 23 09:03:46 volumio volumio[834]: Unable to parse: Feb 23 09:03:46 volumio volumio[834]: Simple mixer control 'SoftMaster',0 Feb 23 09:03:46 volumio volumio[834]: Capabilities: volume Feb 23 09:03:46 volumio volumio[834]: Playback channels: Front Left - Front Right Feb 23 09:03:46 volumio volumio[834]: Capture channels: Front Left - Front Right Feb 23 09:03:46 volumio volumio[834]: Limits: 0 - 99 Feb 23 09:03:46 volumio volumio[834]: Front Left: 89 [90%] Feb 23 09:03:46 volumio volumio[834]: Front Right: 89 [90%] Feb 23 09:03:46 volumio volumio[834]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 23 09:03:46 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:46 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:46 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:46 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:47 volumio volumio[834]: info: VolumeController::SetAlsaVolume- Feb 23 09:03:47 volumio volumio[834]: Unable to parse: Feb 23 09:03:47 volumio volumio[834]: Simple mixer control 'SoftMaster',0 Feb 23 09:03:47 volumio volumio[834]: Capabilities: volume Feb 23 09:03:47 volumio volumio[834]: Playback channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Capture channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Limits: 0 - 99 Feb 23 09:03:47 volumio volumio[834]: Front Left: 84 [85%] Feb 23 09:03:47 volumio volumio[834]: Front Right: 84 [85%] Feb 23 09:03:47 volumio volumio[834]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 23 09:03:47 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:47 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:47 volumio volumio[834]: info: VolumeController::SetAlsaVolume- Feb 23 09:03:47 volumio volumio[834]: Unable to parse: Feb 23 09:03:47 volumio volumio[834]: Simple mixer control 'SoftMaster',0 Feb 23 09:03:47 volumio volumio[834]: Capabilities: volume Feb 23 09:03:47 volumio volumio[834]: Playback channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Capture channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Limits: 0 - 99 Feb 23 09:03:47 volumio volumio[834]: Front Left: 79 [80%] Feb 23 09:03:47 volumio volumio[834]: Front Right: 79 [80%] Feb 23 09:03:47 volumio volumio[834]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 23 09:03:47 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:47 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:47 volumio volumio[834]: info: VolumeController::SetAlsaVolume- Feb 23 09:03:47 volumio volumio[834]: Unable to parse: Feb 23 09:03:47 volumio volumio[834]: Simple mixer control 'SoftMaster',0 Feb 23 09:03:47 volumio volumio[834]: Capabilities: volume Feb 23 09:03:47 volumio volumio[834]: Playback channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Capture channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Limits: 0 - 99 Feb 23 09:03:47 volumio volumio[834]: Front Left: 74 [75%] Feb 23 09:03:47 volumio volumio[834]: Front Right: 74 [75%] Feb 23 09:03:47 volumio volumio[834]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 23 09:03:47 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:47 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:03:47 volumio volumio[834]: info: VolumeController::SetAlsaVolume- Feb 23 09:03:47 volumio volumio[834]: Unable to parse: Feb 23 09:03:47 volumio volumio[834]: Simple mixer control 'SoftMaster',0 Feb 23 09:03:47 volumio volumio[834]: Capabilities: volume Feb 23 09:03:47 volumio volumio[834]: Playback channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Capture channels: Front Left - Front Right Feb 23 09:03:47 volumio volumio[834]: Limits: 0 - 99 Feb 23 09:03:47 volumio volumio[834]: Front Left: 69 [70%] Feb 23 09:03:47 volumio volumio[834]: Front Right: 69 [70%] Feb 23 09:03:47 volumio volumio[834]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Feb 23 09:03:47 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:03:47 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:03:47 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:04:03 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Feb 23 09:04:03 volumio volumio[834]: info: [1740301443770] [80s80s] handleBrowseUri curUri: 80s80s Feb 23 09:04:05 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Feb 23 09:04:05 volumio volumio[834]: info: [1740301445019] [80s80s] handleBrowseUri curUri: 80s80s/eighties Feb 23 09:04:05 volumio volumio[834]: info: [1740301445020] [80s80s] getRadioContent url: eighties Feb 23 09:04:07 volumio volumio[834]: info: CoreCommandRouter::volumioAddQueueItems Feb 23 09:04:07 volumio volumio[834]: info: CoreStateMachine::addQueueItems Feb 23 09:04:07 volumio volumio[834]: info: CorePlayQueue::addQueueItems Feb 23 09:04:07 volumio volumio[834]: info: Adding Item to queue: webeighties/4 Feb 23 09:04:07 volumio volumio[834]: info: Exploding uri webeighties/4 in service 80s80s Feb 23 09:04:07 volumio volumio[834]: info: [1740301447840] [80s80s] explodeUri: webeighties/4 Feb 23 09:04:07 volumio volumio[834]: info: CorePlayQueue::saveQueue Feb 23 09:04:08 volumio volumio[834]: info: CoreCommandRouter::volumioPushQueue Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::updateTrackBlock Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrackBlock Feb 23 09:04:11 volumio volumio[834]: info: CoreCommandRouter::volumioPlay Feb 23 09:04:11 volumio volumio[834]: UNSET VOLATILE Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::play index 48814 Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::stop Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 09:04:11 volumio volumio[834]: UNSET VOLATILE Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::stPlaybackTimer Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::updateTrackBlock Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrackBlock Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:04:11 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:04:11 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::serviceStop Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrack 48813 Feb 23 09:04:11 volumio volumio[834]: info: CoreCommandRouter::serviceStop Feb 23 09:04:11 volumio volumio[834]: info: ControllerMpd::stop Feb 23 09:04:11 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 09:04:11 volumio volumio[834]: info: Feb 23 09:04:11 volumio volumio[834]: ---------------------------- MPD announces state update: player Feb 23 09:04:11 volumio volumio[834]: info: ControllerMpd::getState Feb 23 09:04:11 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::play index undefined Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::startPlaybackTimer Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:11 volumio volumio[834]: info: [1740301451742] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/wave/mp3-192/volumio Feb 23 09:04:11 volumio volumio[834]: info: [1740301451742] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=284&count=2 Feb 23 09:04:11 volumio volumio[834]: verbose: ControllerMpd::parseState Feb 23 09:04:11 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 09:04:11 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo Feb 23 09:04:11 volumio volumio[834]: info: ControllerMpd::pushState Feb 23 09:04:11 volumio volumio[834]: info: CoreCommandRouter::servicePushState Feb 23 09:04:11 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:11 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:04:11 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:04:11 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:11 volumio volumio[834]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Feb 23 09:04:11 volumio volumio[834]: info: ------------------------------ 13ms Feb 23 09:04:12 volumio volumio[834]: info: [1740301452021] [80s80s] received new event containing 2 songs. Feb 23 09:04:12 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 09:04:12 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 09:04:12 volumio volumio[834]: info: Feb 23 09:04:12 volumio volumio[834]: ---------------------------- MPD announces system playlist update Feb 23 09:04:12 volumio volumio[834]: info: Ignoring MPD Status Update Feb 23 09:04:12 volumio volumio[834]: info: [1740301452027] [80s80s] adding url: http://streams.80s80s.de/wave/mp3-192/volumio Feb 23 09:04:12 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/wave/mp3-192/volumio" Feb 23 09:04:12 volumio volumio[834]: error: updateQueue error: null Feb 23 09:04:12 volumio volumio[834]: info: Feb 23 09:04:12 volumio volumio[834]: ---------------------------- MPD announces system playlist update Feb 23 09:04:12 volumio volumio[834]: info: Ignoring MPD Status Update Feb 23 09:04:12 volumio volumio[834]: info: ------------------------------ 5ms Feb 23 09:04:12 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand play Feb 23 09:04:12 volumio volumio[834]: info: ------------------------------ 9ms Feb 23 09:04:12 volumio volumio[834]: info: [1740301452040] [80s80s] Pushing the next song state: Naked Eyes - Promises, Promises Feb 23 09:04:12 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:12 volumio volumio[834]: info: CoreCommandRouter::servicePushState Feb 23 09:04:12 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:12 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music112/v4/4a/8a/3c/4a8a3c90-e939-0f66-34ce-58ead22e914e/5060516092673.png/600x600bb.jpg","name":"Naked Eyes - Promises, Promises","title":"Promises, Promises","artist":"80s80s Wave","album":"","streaming":true,"disableUiControls":true,"duration":"230","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 23 09:04:12 volumio volumio[834]: verbose: CURRENT POSITION 48814 Feb 23 09:04:12 volumio volumio[834]: info: CoreStateMachine::syncState stateService play Feb 23 09:04:12 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus stop Feb 23 09:04:12 volumio volumio[834]: info: CoreStateMachine::pushState Feb 23 09:04:12 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:12 volumio volumio[834]: info: CoreCommandRouter::volumioPushState Feb 23 09:04:12 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 09:04:12 volumio volumio[834]: info: [1740301452079] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Feb 23 09:04:12 volumio volumio[834]: info: CorePlayQueue::getTrack 48814 Feb 23 09:04:12 volumio volumio[834]: info: CorePlayQueue::getTrack 48815 Feb 23 09:04:13 volumio volumio[834]: info: [1740301453115] [80s80s] Failed to query api, status code: 404 Feb 23 09:04:13 volumio volumio[834]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 09:04:13 volumio volumio[834]: ReferenceError: station is not defined Feb 23 09:04:13 volumio volumio[834]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Feb 23 09:04:13 volumio volumio[834]: at Object.onceWrapper (events.js:315:30) Feb 23 09:04:13 volumio volumio[834]: at emitOne (events.js:116:13) Feb 23 09:04:13 volumio volumio[834]: at ClientRequest.emit (events.js:211:7) Feb 23 09:04:13 volumio volumio[834]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Feb 23 09:04:13 volumio volumio[834]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Feb 23 09:04:13 volumio volumio[834]: at Socket.socketOnData (_http_client.js:440:20) Feb 23 09:04:13 volumio volumio[834]: at emitOne (events.js:116:13) Feb 23 09:04:13 volumio volumio[834]: at Socket.emit (events.js:211:7) Feb 23 09:04:13 volumio volumio[834]: at addChunk (_stream_readable.js:263:12) Feb 23 09:04:13 volumio volumio[834]: at readableAddChunk (_stream_readable.js:250:11) Feb 23 09:04:13 volumio volumio[834]: at Socket.Readable.push (_stream_readable.js:208:10) Feb 23 09:04:13 volumio volumio[834]: at TCP.onread (net.js:607:20) Feb 23 09:04:13 volumio volumio[834]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 09:04:13 volumio sudo[4983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 09:03 Feb 23 09:04:13 volumio sudo[4983]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="79c2e7e29d04526018e922852ec460ffc0707dd1" VOLUMIO_FE_VERSION="77c86e8a1bfb19b724ead35c47d417c4832cf290" VOLUMIO_BE_VERSION="f30dbcf35403287bd1b5d6a60fa82e3da7871c6c" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Jul 16 18:57:30 CEST 2020" VOLUMIO_VERSION="2.799" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="5c4ecf8094cc23791be364fa44700bc6"