-- Logs begin at Sun 2024-04-14 10:12:38 UTC, end at Wed 2024-04-17 07:19:06 UTC. -- Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::ClearQueue Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:17 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::stPlaybackTimer Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::updateTrackBlock Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::getTrackBlock Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::serviceStop Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::serviceStop Apr 17 07:18:17 volumio volumio[912]: info: [1713338297455] ControllerWebradio::stop Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::clearPlayQueue Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::addQueueItems Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::addQueueItems Apr 17 07:18:17 volumio volumio[912]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s136422 Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::updateTrackBlock Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::getTrackBlock Apr 17 07:18:17 volumio volumio[912]: info: CoreCommandRouter::volumioPlay Apr 17 07:18:17 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::play index 0 Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:17 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::play index undefined Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:17 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Apr 17 07:18:17 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:17 volumio volumio[912]: info: [1713338297473] ControllerWebradio::clearAddPlayTrack Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Apr 17 07:18:17 volumio volumio[912]: info: Apr 17 07:18:17 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:17 volumio volumio[912]: info: sendMpdCommand stop took 76 milliseconds Apr 17 07:18:17 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:17 volumio volumio[912]: info: sendMpdCommand stop took 57 milliseconds Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand clear Apr 17 07:18:17 volumio volumio[912]: info: Apr 17 07:18:17 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:17 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:17 volumio volumio[912]: info: sendMpdCommand status took 3 milliseconds Apr 17 07:18:17 volumio volumio[912]: info: sendMpdCommand clear took 3 milliseconds Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand load "http://jpopsuki.fm:8000/stream" Apr 17 07:18:17 volumio volumio[912]: error: updateQueue error: null Apr 17 07:18:17 volumio volumio[912]: info: ------------------------------ 5ms Apr 17 07:18:17 volumio volumio[912]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 17 07:18:17 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:17 volumio volumio[912]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 17 07:18:17 volumio volumio[912]: info: ------------------------------ 10ms Apr 17 07:18:18 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand add "http://jpopsuki.fm:8000/stream" Apr 17 07:18:18 volumio volumio[912]: info: Apr 17 07:18:18 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:18 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:18 volumio volumio[912]: info: sendMpdCommand add "http://jpopsuki.fm:8000/stream" took 3 milliseconds Apr 17 07:18:18 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 17 07:18:18 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand play Apr 17 07:18:18 volumio volumio[912]: info: ------------------------------ 4ms Apr 17 07:18:18 volumio volumio[912]: info: sendMpdCommand play took 2 milliseconds Apr 17 07:18:20 volumio volumio[912]: info: Apr 17 07:18:20 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:20 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:20 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 17 07:18:20 volumio volumio[912]: info: Apr 17 07:18:20 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:20 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:20 volumio volumio[912]: info: Apr 17 07:18:20 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:20 volumio volumio[912]: info: sendMpdCommand status took 34 milliseconds Apr 17 07:18:20 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:20 volumio volumio[912]: info: Apr 17 07:18:20 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:20 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:20 volumio volumio[912]: info: Apr 17 07:18:20 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:20 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:20 volumio volumio[912]: info: ------------------------------ 7ms Apr 17 07:18:20 volumio volumio[912]: info: sendMpdCommand status took 5 milliseconds Apr 17 07:18:20 volumio volumio[912]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:20 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:20 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:20 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Hora - VENOM","artist":"JPopsuki Radio!","album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""} Apr 17 07:18:20 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:20 volumio volumio[912]: info: ------------------------------ 59ms Apr 17 07:18:20 volumio volumio[912]: info: ------------------------------ 22ms Apr 17 07:18:20 volumio volumio[912]: info: sendMpdCommand status took 20 milliseconds Apr 17 07:18:20 volumio volumio[912]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:20 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:20 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:20 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Hora - VENOM","artist":"JPopsuki Radio!","album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""} Apr 17 07:18:20 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Apr 17 07:18:20 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:20 volumio volumio[912]: info: ------------------------------ 39ms Apr 17 07:18:20 volumio volumio[912]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 17 07:18:20 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:20 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:20 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:20 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Hora - VENOM","artist":"JPopsuki Radio!","album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""} Apr 17 07:18:20 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Apr 17 07:18:20 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:20 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:20 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:20 volumio volumio[912]: info: ------------------------------ 51ms Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::ClearQueue Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:33 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::stPlaybackTimer Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::updateTrackBlock Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrackBlock Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::serviceStop Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::serviceStop Apr 17 07:18:33 volumio volumio[912]: info: [1713338313228] ControllerWebradio::stop Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::clearPlayQueue Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::addQueueItems Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::addQueueItems Apr 17 07:18:33 volumio volumio[912]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s97839 Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 17 07:18:33 volumio volumio[912]: info: Apr 17 07:18:33 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:33 volumio volumio[912]: info: sendMpdCommand stop took 97 milliseconds Apr 17 07:18:33 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:33 volumio volumio[912]: info: sendMpdCommand status took 1 milliseconds Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:33 volumio volumio[912]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:33 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: 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":"Hora - VENOM","artist":"JPopsuki Radio!","album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""} Apr 17 07:18:33 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::syncState stateService stop Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:33 volumio volumio[912]: info: No code Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:33 volumio volumio[912]: info: ------------------------------ 18ms Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::updateTrackBlock Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrackBlock Apr 17 07:18:33 volumio volumio[912]: info: CoreCommandRouter::volumioPlay Apr 17 07:18:33 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::play index 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:33 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::play index undefined Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Apr 17 07:18:33 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:33 volumio volumio[912]: info: [1713338313543] ControllerWebradio::clearAddPlayTrack Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Apr 17 07:18:33 volumio volumio[912]: info: sendMpdCommand stop took 12 milliseconds Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand clear Apr 17 07:18:33 volumio volumio[912]: info: Apr 17 07:18:33 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:33 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:33 volumio volumio[912]: info: sendMpdCommand clear took 1 milliseconds Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand load "http://gyusyabu.ddo.jp:8000/;" Apr 17 07:18:33 volumio volumio[912]: error: updateQueue error: null Apr 17 07:18:33 volumio volumio[912]: info: ------------------------------ 2ms Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand add "http://gyusyabu.ddo.jp:8000/;" Apr 17 07:18:33 volumio volumio[912]: info: Apr 17 07:18:33 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:33 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:33 volumio volumio[912]: info: sendMpdCommand add "http://gyusyabu.ddo.jp:8000/;" took 1 milliseconds Apr 17 07:18:33 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 17 07:18:33 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand play Apr 17 07:18:33 volumio volumio[912]: info: ------------------------------ 2ms Apr 17 07:18:33 volumio volumio[912]: info: sendMpdCommand play took 1 milliseconds Apr 17 07:18:34 volumio volumio[912]: info: Apr 17 07:18:34 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:34 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 17 07:18:34 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:34 volumio volumio[912]: info: sendMpdCommand status took 30 milliseconds Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:34 volumio volumio[912]: info: Apr 17 07:18:34 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:34 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:34 volumio volumio[912]: info: Apr 17 07:18:34 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:34 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:34 volumio volumio[912]: info: Apr 17 07:18:34 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:34 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:34 volumio volumio[912]: info: Apr 17 07:18:34 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:34 volumio volumio[912]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 17 07:18:34 volumio volumio[912]: info: ------------------------------ 5ms Apr 17 07:18:34 volumio volumio[912]: info: sendMpdCommand status took 4 milliseconds Apr 17 07:18:34 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:34 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:34 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:34 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":";","artist":"Retro PC Game Music Streaming Radio for Gyusyabu","album":null,"uri":"http://gyusyabu.ddo.jp:8000/;","trackType":"jp:8000/;"} Apr 17 07:18:34 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:34 volumio volumio[912]: info: ------------------------------ 51ms Apr 17 07:18:34 volumio volumio[912]: info: ------------------------------ 15ms Apr 17 07:18:34 volumio volumio[912]: info: sendMpdCommand status took 12 milliseconds Apr 17 07:18:34 volumio volumio[912]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:34 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:34 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:34 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":438,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"?X?^?[?V?b?v?????f?u?[ for PC88SR [SoundBoard II] 01. Operation in Unsteady Space [Opening] (C)1988 ScapTrust, (C)ARKLIGHT ","artist":"Retro PC Game Music Streaming Radio for Gyusyabu","album":null,"uri":"http://gyusyabu.ddo.jp:8000/;","trackType":"jp:8000/;"} Apr 17 07:18:34 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Apr 17 07:18:34 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:34 volumio volumio[912]: info: ------------------------------ 30ms Apr 17 07:18:34 volumio volumio[912]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 17 07:18:34 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:34 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:34 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:34 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"?X?^?[?V?b?v?????f?u?[ for PC88SR [SoundBoard II] 01. Operation in Unsteady Space [Opening] (C)1988 ScapTrust, (C)ARKLIGHT ","artist":"Retro PC Game Music Streaming Radio for Gyusyabu","album":null,"uri":"http://gyusyabu.ddo.jp:8000/;","trackType":"jp:8000/;"} Apr 17 07:18:34 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus play Apr 17 07:18:34 volumio volumio[912]: info: Received an update from plugin. extracting info from payload Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:34 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:34 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:34 volumio volumio[912]: info: ------------------------------ 43ms Apr 17 07:18:53 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , handleBrowseUri Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::ClearQueue Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:56 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::stPlaybackTimer Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::updateTrackBlock Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::getTrackBlock Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::serviceStop Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::serviceStop Apr 17 07:18:56 volumio volumio[912]: info: [1713338336587] ControllerWebradio::stop Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::clearPlayQueue Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::addQueueItems Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::addQueueItems Apr 17 07:18:56 volumio volumio[912]: info: Adding Item to queue: webrp/0 Apr 17 07:18:56 volumio volumio[912]: info: Exploding uri webrp/0 in service radio_paradise Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::updateTrackBlock Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::getTrackBlock Apr 17 07:18:56 volumio volumio[912]: info: CoreCommandRouter::volumioPlay Apr 17 07:18:56 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::play index 0 Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:56 volumio volumio[912]: UNSET VOLATILE Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::play index undefined Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:56 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Apr 17 07:18:56 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Apr 17 07:18:56 volumio volumio[912]: info: Apr 17 07:18:56 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand stop took 56 milliseconds Apr 17 07:18:56 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand stop took 31 milliseconds Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand clear Apr 17 07:18:56 volumio volumio[912]: info: Apr 17 07:18:56 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:56 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand status took 4 milliseconds Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand clear took 2 milliseconds Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 17 07:18:56 volumio volumio[912]: error: updateQueue error: null Apr 17 07:18:56 volumio volumio[912]: info: ------------------------------ 4ms Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand consume 1 took 3 milliseconds Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:56 volumio volumio[912]: info: [1713338336653] [RadioParadise] set to consume mode, adding url: http://stream.radioparadise.com/flac Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/flac" Apr 17 07:18:56 volumio volumio[912]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 17 07:18:56 volumio volumio[912]: info: ------------------------------ 11ms Apr 17 07:18:56 volumio volumio[912]: info: Apr 17 07:18:56 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:56 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand add "http://stream.radioparadise.com/flac" took 3 milliseconds Apr 17 07:18:56 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand play Apr 17 07:18:56 volumio volumio[912]: info: ------------------------------ 5ms Apr 17 07:18:56 volumio volumio[912]: info: sendMpdCommand play took 2 milliseconds Apr 17 07:18:56 volumio volumio[912]: info: [1713338336662] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Apr 17 07:18:57 volumio volumio[912]: info: [1713338337234] [RadioParadise] Error: certificate has expired Apr 17 07:18:57 volumio volumio[912]: info: Apr 17 07:18:57 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:57 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:57 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 17 07:18:57 volumio volumio[912]: info: Apr 17 07:18:57 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:18:57 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:18:57 volumio volumio[912]: info: Apr 17 07:18:57 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:18:57 volumio volumio[912]: info: sendMpdCommand status took 33 milliseconds Apr 17 07:18:57 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:57 volumio volumio[912]: info: ------------------------------ 5ms Apr 17 07:18:57 volumio volumio[912]: info: sendMpdCommand status took 4 milliseconds Apr 17 07:18:57 volumio volumio[912]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:57 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:57 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:57 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:57 volumio volumio[912]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Apr 17 07:18:57 volumio volumio[912]: info: ------------------------------ 42ms Apr 17 07:18:57 volumio volumio[912]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 17 07:18:57 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:18:57 volumio volumio[912]: info: ControllerMpd::pushState Apr 17 07:18:57 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:18:57 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:18:57 volumio volumio[912]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Apr 17 07:18:57 volumio volumio[912]: info: ------------------------------ 10ms Apr 17 07:19:01 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Apr 17 07:19:01 volumio volumio[912]: info: [1713338341284] [80s80s] handleBrowseUri curUri: 80s80s Apr 17 07:19:02 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Apr 17 07:19:02 volumio volumio[912]: info: [1713338342780] [80s80s] handleBrowseUri curUri: 80s80s/nineties Apr 17 07:19:02 volumio volumio[912]: info: [1713338342781] [80s80s] getRadioContent url: nineties Apr 17 07:19:04 volumio volumio[912]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::ClearQueue Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:19:04 volumio volumio[912]: UNSET VOLATILE Apr 17 07:19:04 volumio volumio[912]: info: CorePlayQueue::clearPlayQueue Apr 17 07:19:04 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:19:04 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:19:04 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:19:04 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::addQueueItems Apr 17 07:19:04 volumio volumio[912]: info: CorePlayQueue::addQueueItems Apr 17 07:19:04 volumio volumio[912]: info: Adding Item to queue: webnineties/0 Apr 17 07:19:04 volumio volumio[912]: info: Exploding uri webnineties/0 in service 80s80s Apr 17 07:19:04 volumio volumio[912]: info: [1713338344808] [80s80s] explodeUri: webnineties/0 Apr 17 07:19:04 volumio volumio[912]: info: CorePlayQueue::saveQueue Apr 17 07:19:04 volumio volumio[912]: info: CoreCommandRouter::volumioPushQueue Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::updateTrackBlock Apr 17 07:19:04 volumio volumio[912]: info: CorePlayQueue::getTrackBlock Apr 17 07:19:04 volumio volumio[912]: info: CoreCommandRouter::volumioPlay Apr 17 07:19:04 volumio volumio[912]: UNSET VOLATILE Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::play index 0 Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::stop Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:19:04 volumio volumio[912]: UNSET VOLATILE Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::play index undefined Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 17 07:19:04 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:19:04 volumio volumio[912]: info: CoreStateMachine::startPlaybackTimer Apr 17 07:19:04 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:19:04 volumio volumio[912]: info: [1713338344819] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/pop/mp3-192/volumio Apr 17 07:19:04 volumio volumio[912]: info: [1713338344820] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=141&count=2 Apr 17 07:19:05 volumio volumio[912]: info: [1713338345552] [80s80s] received new event containing 2 songs. Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Apr 17 07:19:05 volumio volumio[912]: info: Apr 17 07:19:05 volumio volumio[912]: ---------------------------- MPD announces state update: player Apr 17 07:19:05 volumio volumio[912]: info: sendMpdCommand stop took 81 milliseconds Apr 17 07:19:05 volumio volumio[912]: info: ControllerMpd::getState Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand status Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand clear Apr 17 07:19:05 volumio volumio[912]: info: Apr 17 07:19:05 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:19:05 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:19:05 volumio volumio[912]: info: sendMpdCommand status took 3 milliseconds Apr 17 07:19:05 volumio volumio[912]: info: sendMpdCommand clear took 3 milliseconds Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::parseState Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 17 07:19:05 volumio volumio[912]: info: [1713338345640] [80s80s] adding url: http://streams.90s90s.de/pop/mp3-192/volumio Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/pop/mp3-192/volumio" Apr 17 07:19:05 volumio volumio[912]: error: updateQueue error: null Apr 17 07:19:05 volumio volumio[912]: info: Apr 17 07:19:05 volumio volumio[912]: ---------------------------- MPD announces system playlist update Apr 17 07:19:05 volumio volumio[912]: info: Ignoring MPD Status Update Apr 17 07:19:05 volumio volumio[912]: info: ------------------------------ 5ms Apr 17 07:19:05 volumio volumio[912]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 17 07:19:05 volumio volumio[912]: info: sendMpdCommand add "http://streams.90s90s.de/pop/mp3-192/volumio" took 4 milliseconds Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::parseTrackInfo Apr 17 07:19:05 volumio volumio[912]: verbose: ControllerMpd::sendMpdCommand play Apr 17 07:19:05 volumio volumio[912]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 17 07:19:05 volumio volumio[912]: info: ------------------------------ 15ms Apr 17 07:19:05 volumio volumio[912]: info: ------------------------------ 7ms Apr 17 07:19:05 volumio volumio[912]: info: sendMpdCommand play took 13 milliseconds Apr 17 07:19:05 volumio volumio[912]: info: [1713338345661] [80s80s] Pushing the next song state: Masterboy - Generation of Love (Ipanema Apr 17 07:19:05 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:19:05 volumio volumio[912]: info: CoreCommandRouter::servicePushState Apr 17 07:19:05 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:19:05 volumio volumio[912]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music126/v4/f6/5d/46/f65d46fb-7f97-006c-9ce6-777c3241f3c4/cover.jpg/600x600bb.jpg","name":"Masterboy - Generation of Love (Ipanema","title":"Generation of Love (Ipanema","artist":"90s90s Hits","album":"","streaming":true,"disableUiControls":true,"duration":"214","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Apr 17 07:19:05 volumio volumio[912]: verbose: CURRENT POSITION 0 Apr 17 07:19:05 volumio volumio[912]: info: CoreStateMachine::syncState stateService play Apr 17 07:19:05 volumio volumio[912]: info: CoreStateMachine::syncState currentStatus stop Apr 17 07:19:05 volumio volumio[912]: info: CoreStateMachine::pushState Apr 17 07:19:05 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:19:05 volumio volumio[912]: info: CoreCommandRouter::volumioPushState Apr 17 07:19:05 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 07:19:05 volumio volumio[912]: info: [1713338345675] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Apr 17 07:19:05 volumio volumio[912]: info: CorePlayQueue::getTrack 0 Apr 17 07:19:05 volumio volumio[912]: info: CorePlayQueue::getTrack 1 Apr 17 07:19:05 volumio volumio[912]: info: [1713338345840] [80s80s] Failed to query api, status code: 404 Apr 17 07:19:05 volumio volumio[912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 07:19:05 volumio volumio[912]: ReferenceError: station is not defined Apr 17 07:19:05 volumio volumio[912]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Apr 17 07:19:05 volumio volumio[912]: at Object.onceWrapper (events.js:315:30) Apr 17 07:19:05 volumio volumio[912]: at emitOne (events.js:116:13) Apr 17 07:19:05 volumio volumio[912]: at ClientRequest.emit (events.js:211:7) Apr 17 07:19:05 volumio volumio[912]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Apr 17 07:19:05 volumio volumio[912]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Apr 17 07:19:05 volumio volumio[912]: at Socket.socketOnData (_http_client.js:440:20) Apr 17 07:19:05 volumio volumio[912]: at emitOne (events.js:116:13) Apr 17 07:19:05 volumio volumio[912]: at Socket.emit (events.js:211:7) Apr 17 07:19:05 volumio volumio[912]: at addChunk (_stream_readable.js:263:12) Apr 17 07:19:05 volumio volumio[912]: at readableAddChunk (_stream_readable.js:250:11) Apr 17 07:19:05 volumio volumio[912]: at Socket.Readable.push (_stream_readable.js:208:10) Apr 17 07:19:05 volumio volumio[912]: at TCP.onread (net.js:607:20) Apr 17 07:19:05 volumio volumio[912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 07:19:06 volumio sudo[27344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-17 07:18 Apr 17 07:19:06 volumio sudo[27344]: 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="14acf028cf46278bd3fd3dd02523424a9bc825bf" VOLUMIO_FE_VERSION="74f64fbba9dc8053dc27ed7125863d6ad6533965" VOLUMIO_BE_VERSION="0a6008ded215bf284d5d4cd9c4df3333cb320899" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Apr 24 17:39:58 CEST 2021" VOLUMIO_VERSION="2.882" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="1a98a01eef5aa5927a5874c2d3c1b0dc"