-- Logs begin at Thu 2024-04-18 06:15:02 UTC, end at Thu 2024-04-18 07:00:09 UTC. -- Apr 18 06:59:19 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 18 06:59:23 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 18 06:59:23 lgzhifi volumio[5939]: info: Getting webradio selection Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::ClearQueue Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::stPlaybackTimer Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::updateTrackBlock Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::getTrackBlock Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::pushState Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::serviceStop Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::serviceStop Apr 18 06:59:31 lgzhifi volumio[5939]: info: [1713423571394] ControllerWebradio::stop Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::clearPlayQueue Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::addQueueItems Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::addQueueItems Apr 18 06:59:31 lgzhifi volumio[5939]: info: Adding Item to queue: http://stream.absolutradio.de/hq/mp3-160/radioplayer/ Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::updateTrackBlock Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::getTrackBlock Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPlay Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::play index 0 Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::play index undefined Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:31 lgzhifi volumio[5939]: info: CoreStateMachine::startPlaybackTimer Apr 18 06:59:31 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:31 lgzhifi volumio[5939]: info: [1713423571421] ControllerWebradio::clearAddPlayTrack Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 06:59:31 lgzhifi volumio[5939]: info: Apr 18 06:59:31 lgzhifi volumio[5939]: ---------------------------- MPD announces state update: player Apr 18 06:59:31 lgzhifi volumio[5939]: info: sendMpdCommand stop took 72 milliseconds Apr 18 06:59:31 lgzhifi volumio[5939]: info: ControllerMpd::getState Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand status Apr 18 06:59:31 lgzhifi volumio[5939]: info: sendMpdCommand stop took 46 milliseconds Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 06:59:31 lgzhifi volumio[5939]: info: Apr 18 06:59:31 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:31 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:31 lgzhifi volumio[5939]: info: sendMpdCommand status took 2 milliseconds Apr 18 06:59:31 lgzhifi volumio[5939]: info: sendMpdCommand clear took 2 milliseconds Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::parseState Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand load "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Apr 18 06:59:31 lgzhifi volumio[5939]: error: updateQueue error: null Apr 18 06:59:31 lgzhifi volumio[5939]: info: ------------------------------ 5ms Apr 18 06:59:31 lgzhifi volumio[5939]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 18 06:59:31 lgzhifi volumio[5939]: verbose: ControllerMpd::parseTrackInfo Apr 18 06:59:31 lgzhifi volumio[5939]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 18 06:59:31 lgzhifi volumio[5939]: info: ------------------------------ 9ms Apr 18 06:59:34 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Apr 18 06:59:34 lgzhifi volumio[5939]: info: Apr 18 06:59:34 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:34 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:34 lgzhifi volumio[5939]: info: sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" took 4 milliseconds Apr 18 06:59:34 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 18 06:59:34 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand play Apr 18 06:59:34 lgzhifi volumio[5939]: info: ------------------------------ 4ms Apr 18 06:59:34 lgzhifi volumio[5939]: info: sendMpdCommand play took 4 milliseconds Apr 18 06:59:36 lgzhifi volumio[5939]: info: Apr 18 06:59:36 lgzhifi volumio[5939]: ---------------------------- MPD announces state update: player Apr 18 06:59:36 lgzhifi volumio[5939]: info: ControllerMpd::getState Apr 18 06:59:36 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand status Apr 18 06:59:36 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 18 06:59:36 lgzhifi volumio[5939]: info: sendMpdCommand status took 5 milliseconds Apr 18 06:59:36 lgzhifi volumio[5939]: verbose: ControllerMpd::parseState Apr 18 06:59:36 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 06:59:36 lgzhifi volumio[5939]: info: sendMpdCommand clearerror took 2 milliseconds Apr 18 06:59:36 lgzhifi volumio[5939]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 18 06:59:36 lgzhifi volumio[5939]: verbose: ControllerMpd::parseTrackInfo Apr 18 06:59:36 lgzhifi volumio[5939]: info: ControllerMpd::pushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreCommandRouter::servicePushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreStateMachine::pushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:36 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:36 lgzhifi volumio[5939]: 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":"","artist":null,"album":null,"uri":"http://stream.absolutradio.de/hq/mp3-160/radioplayer/","trackType":""} Apr 18 06:59:36 lgzhifi volumio[5939]: verbose: CURRENT POSITION 0 Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreStateMachine::syncState stateService stop Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreStateMachine::syncState currentStatus stop Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreStateMachine::pushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:36 lgzhifi volumio[5939]: info: No code Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreStateMachine::pushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:36 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:36 lgzhifi volumio[5939]: info: ------------------------------ 30ms Apr 18 06:59:37 lgzhifi nmbd[795]: [2024/04/18 06:59:37.093875, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 18 06:59:37 lgzhifi nmbd[795]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::ClearQueue Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:42 lgzhifi volumio[5939]: info: CorePlayQueue::clearPlayQueue Apr 18 06:59:42 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::addQueueItems Apr 18 06:59:42 lgzhifi volumio[5939]: info: CorePlayQueue::addQueueItems Apr 18 06:59:42 lgzhifi volumio[5939]: info: Adding Item to queue: http://stream.absolutradio.de/relax/mp3-160/radioplayer/ Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 18 06:59:42 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::updateTrackBlock Apr 18 06:59:42 lgzhifi volumio[5939]: info: CorePlayQueue::getTrackBlock Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPlay Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::play index 0 Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::play index undefined Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:42 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::startPlaybackTimer Apr 18 06:59:42 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:42 lgzhifi volumio[5939]: info: [1713423582369] ControllerWebradio::clearAddPlayTrack Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 06:59:42 lgzhifi volumio[5939]: info: sendMpdCommand stop took 7 milliseconds Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 06:59:42 lgzhifi volumio[5939]: info: Apr 18 06:59:42 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:42 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:42 lgzhifi volumio[5939]: info: sendMpdCommand clear took 2 milliseconds Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand load "http://stream.absolutradio.de/relax/mp3-160/radioplayer/" Apr 18 06:59:42 lgzhifi volumio[5939]: error: updateQueue error: null Apr 18 06:59:42 lgzhifi volumio[5939]: info: ------------------------------ 3ms Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand add "http://stream.absolutradio.de/relax/mp3-160/radioplayer/" Apr 18 06:59:42 lgzhifi volumio[5939]: info: Apr 18 06:59:42 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:42 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:42 lgzhifi volumio[5939]: info: sendMpdCommand add "http://stream.absolutradio.de/relax/mp3-160/radioplayer/" took 1 milliseconds Apr 18 06:59:42 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 18 06:59:42 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand play Apr 18 06:59:42 lgzhifi volumio[5939]: info: ------------------------------ 8ms Apr 18 06:59:42 lgzhifi volumio[5939]: info: sendMpdCommand play took 7 milliseconds Apr 18 06:59:43 lgzhifi volumio[5939]: info: Apr 18 06:59:43 lgzhifi volumio[5939]: ---------------------------- MPD announces state update: player Apr 18 06:59:43 lgzhifi volumio[5939]: info: ControllerMpd::getState Apr 18 06:59:43 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand status Apr 18 06:59:43 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 18 06:59:43 lgzhifi volumio[5939]: info: sendMpdCommand status took 6 milliseconds Apr 18 06:59:43 lgzhifi volumio[5939]: verbose: ControllerMpd::parseState Apr 18 06:59:43 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 06:59:43 lgzhifi volumio[5939]: info: sendMpdCommand clearerror took 5 milliseconds Apr 18 06:59:43 lgzhifi volumio[5939]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 18 06:59:43 lgzhifi volumio[5939]: verbose: ControllerMpd::parseTrackInfo Apr 18 06:59:43 lgzhifi volumio[5939]: info: ControllerMpd::pushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreCommandRouter::servicePushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreStateMachine::pushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:43 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:43 lgzhifi volumio[5939]: 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":"","artist":null,"album":null,"uri":"http://stream.absolutradio.de/relax/mp3-160/radioplayer/","trackType":""} Apr 18 06:59:43 lgzhifi volumio[5939]: verbose: CURRENT POSITION 0 Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreStateMachine::syncState stateService stop Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreStateMachine::syncState currentStatus stop Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreStateMachine::pushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:43 lgzhifi volumio[5939]: info: No code Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreStateMachine::pushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:43 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:43 lgzhifi volumio[5939]: info: ------------------------------ 38ms Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::ClearQueue Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:44 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:44 lgzhifi volumio[5939]: info: CorePlayQueue::clearPlayQueue Apr 18 06:59:44 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::addQueueItems Apr 18 06:59:44 lgzhifi volumio[5939]: info: CorePlayQueue::addQueueItems Apr 18 06:59:44 lgzhifi volumio[5939]: info: Adding Item to queue: http://119.15.96.188/stream2.mp3 Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 18 06:59:44 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::updateTrackBlock Apr 18 06:59:44 lgzhifi volumio[5939]: info: CorePlayQueue::getTrackBlock Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPlay Apr 18 06:59:44 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::play index 0 Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:44 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::play index undefined Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:44 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:44 lgzhifi volumio[5939]: info: CoreStateMachine::startPlaybackTimer Apr 18 06:59:44 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:44 lgzhifi volumio[5939]: info: [1713423584285] ControllerWebradio::clearAddPlayTrack Apr 18 06:59:44 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 06:59:44 lgzhifi volumio[5939]: info: sendMpdCommand stop took 9 milliseconds Apr 18 06:59:44 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 06:59:44 lgzhifi volumio[5939]: info: Apr 18 06:59:44 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:44 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:44 lgzhifi volumio[5939]: info: sendMpdCommand clear took 2 milliseconds Apr 18 06:59:44 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand load "http://119.15.96.188/stream2.mp3" Apr 18 06:59:44 lgzhifi volumio[5939]: error: updateQueue error: null Apr 18 06:59:44 lgzhifi volumio[5939]: info: ------------------------------ 16ms Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::ClearQueue Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:52 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:52 lgzhifi volumio[5939]: info: CorePlayQueue::clearPlayQueue Apr 18 06:59:52 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::addQueueItems Apr 18 06:59:52 lgzhifi volumio[5939]: info: CorePlayQueue::addQueueItems Apr 18 06:59:52 lgzhifi volumio[5939]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_radio_one Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 18 06:59:52 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::updateTrackBlock Apr 18 06:59:52 lgzhifi volumio[5939]: info: CorePlayQueue::getTrackBlock Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPlay Apr 18 06:59:52 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::play index 0 Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:52 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::play index undefined Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 06:59:52 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:52 lgzhifi volumio[5939]: info: CoreStateMachine::startPlaybackTimer Apr 18 06:59:52 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 06:59:52 lgzhifi volumio[5939]: info: [1713423592393] ControllerWebradio::clearAddPlayTrack Apr 18 06:59:52 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 06:59:54 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand add "http://119.15.96.188/stream2.mp3" Apr 18 06:59:54 lgzhifi volumio[5939]: info: sendMpdCommand stop took 1925 milliseconds Apr 18 06:59:54 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 06:59:54 lgzhifi volumio[5939]: info: Apr 18 06:59:54 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:54 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:54 lgzhifi volumio[5939]: info: sendMpdCommand add "http://119.15.96.188/stream2.mp3" took 3 milliseconds Apr 18 06:59:54 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 18 06:59:54 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand play Apr 18 06:59:54 lgzhifi volumio[5939]: info: Apr 18 06:59:54 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:54 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:54 lgzhifi volumio[5939]: error: updateQueue error: null Apr 18 06:59:54 lgzhifi volumio[5939]: info: sendMpdCommand clear took 10 milliseconds Apr 18 06:59:54 lgzhifi volumio[5939]: info: ------------------------------ 11ms Apr 18 06:59:54 lgzhifi volumio[5939]: info: sendMpdCommand play took 5 milliseconds Apr 18 06:59:54 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_one" Apr 18 06:59:54 lgzhifi volumio[5939]: error: updateQueue error: null Apr 18 06:59:54 lgzhifi volumio[5939]: info: ------------------------------ 5ms Apr 18 06:59:55 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_one" Apr 18 06:59:55 lgzhifi volumio[5939]: info: Apr 18 06:59:55 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 06:59:55 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 06:59:55 lgzhifi volumio[5939]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_one" took 2 milliseconds Apr 18 06:59:55 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 18 06:59:55 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand play Apr 18 06:59:55 lgzhifi volumio[5939]: info: ------------------------------ 2ms Apr 18 06:59:55 lgzhifi volumio[5939]: info: sendMpdCommand play took 1 milliseconds Apr 18 06:59:56 lgzhifi volumio[5939]: info: Apr 18 06:59:56 lgzhifi volumio[5939]: ---------------------------- MPD announces state update: player Apr 18 06:59:56 lgzhifi volumio[5939]: info: ControllerMpd::getState Apr 18 06:59:56 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand status Apr 18 06:59:56 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 18 06:59:56 lgzhifi volumio[5939]: info: sendMpdCommand status took 4 milliseconds Apr 18 06:59:56 lgzhifi volumio[5939]: verbose: ControllerMpd::parseState Apr 18 06:59:56 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 06:59:56 lgzhifi volumio[5939]: info: sendMpdCommand clearerror took 2 milliseconds Apr 18 06:59:56 lgzhifi volumio[5939]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 18 06:59:56 lgzhifi volumio[5939]: verbose: ControllerMpd::parseTrackInfo Apr 18 06:59:56 lgzhifi volumio[5939]: error: ControllerMpd::pushError: TypeError: Cannot read property 'replace' of undefined Apr 18 06:59:56 lgzhifi volumio[5939]: info: ------------------------------ 8ms Apr 18 07:00:00 lgzhifi volumio[5939]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Blues%20Radio/4573605a-1394-4c56-b845-455e61c9fef2.jpg' Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::ClearQueue Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 07:00:01 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 07:00:01 lgzhifi volumio[5939]: info: CorePlayQueue::clearPlayQueue Apr 18 07:00:01 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushState Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::addQueueItems Apr 18 07:00:01 lgzhifi volumio[5939]: info: CorePlayQueue::addQueueItems Apr 18 07:00:01 lgzhifi volumio[5939]: info: Adding Item to queue: http://167.114.64.181:8153/listen.pls?sid=1 Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 18 07:00:01 lgzhifi volumio[5939]: info: CorePlayQueue::saveQueue Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPushQueue Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::updateTrackBlock Apr 18 07:00:01 lgzhifi volumio[5939]: info: CorePlayQueue::getTrackBlock Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreCommandRouter::volumioPlay Apr 18 07:00:01 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::play index 0 Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::stop Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 07:00:01 lgzhifi volumio[5939]: verbose: UNSET VOLATILE Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::play index undefined Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 07:00:01 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 07:00:01 lgzhifi volumio[5939]: info: CoreStateMachine::startPlaybackTimer Apr 18 07:00:01 lgzhifi volumio[5939]: info: CorePlayQueue::getTrack 0 Apr 18 07:00:01 lgzhifi volumio[5939]: info: [1713423601369] ControllerWebradio::clearAddPlayTrack Apr 18 07:00:01 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 07:00:01 lgzhifi volumio[5939]: info: sendMpdCommand stop took 9 milliseconds Apr 18 07:00:01 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 07:00:01 lgzhifi volumio[5939]: info: Apr 18 07:00:01 lgzhifi volumio[5939]: ---------------------------- MPD announces system playlist update Apr 18 07:00:01 lgzhifi volumio[5939]: info: Ignoring MPD Status Update Apr 18 07:00:01 lgzhifi volumio[5939]: info: sendMpdCommand clear took 2 milliseconds Apr 18 07:00:01 lgzhifi volumio[5939]: verbose: ControllerMpd::sendMpdCommand load "http://167.114.64.181:8153/listen.pls?sid=1" Apr 18 07:00:09 lgzhifi volumio[5939]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 07:00:09 lgzhifi volumio[5939]: { Error: connect ETIMEDOUT 122.10.85.4:80 Apr 18 07:00:09 lgzhifi volumio[5939]: at Object._errnoException (util.js:1022:11) Apr 18 07:00:09 lgzhifi volumio[5939]: at _exceptionWithHostPort (util.js:1044:20) Apr 18 07:00:09 lgzhifi volumio[5939]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 18 07:00:09 lgzhifi volumio[5939]: code: 'ETIMEDOUT', Apr 18 07:00:09 lgzhifi volumio[5939]: errno: 'ETIMEDOUT', Apr 18 07:00:09 lgzhifi volumio[5939]: syscall: 'connect', Apr 18 07:00:09 lgzhifi volumio[5939]: address: '122.10.85.4', Apr 18 07:00:09 lgzhifi volumio[5939]: port: 80 } Apr 18 07:00:09 lgzhifi volumio[5939]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 07:00:09 lgzhifi sudo[8286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-18 06:59 Apr 18 07:00:09 lgzhifi sudo[8286]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"