-- Logs begin at Mon 2024-10-21 04:51:27 CST, end at Mon 2024-10-21 05:03:14 CST. -- Oct 21 05:02:02 yhb-volumio ntpd[7334]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 21 05:02:02 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 21 05:02:08 yhb-volumio volumio[6129]: info: Preload queue cleared Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Preload queue cleared Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::ClearQueue Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::stop Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::stPlaybackTimer Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::updateTrackBlock Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrackBlock Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::serviceStop Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::serviceStop Oct 21 05:02:10 yhb-volumio volumio[6129]: info: [1729458130607] ControllerWebradio::stop Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::clearPlayQueue Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::saveQueue Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushQueue Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::addQueueItems Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::addQueueItems Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Preload queue cleared Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99596973 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushQueue Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::saveQueue Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::updateTrackBlock Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrackBlock Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPlay Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::play index 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::stop Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::play index undefined Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::startPlaybackTimer Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: [1729458130641] ControllerWebradio::clearAddPlayTrack Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand stop Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Oct 21 05:02:10 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:10 yhb-volumio volumio[6129]: info: sendMpdCommand stop took 144 milliseconds Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:10 yhb-volumio volumio[6129]: info: sendMpdCommand stop took 110 milliseconds Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand clear Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Oct 21 05:02:10 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Oct 21 05:02:10 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Oct 21 05:02:10 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:10 yhb-volumio volumio[6129]: info: sendMpdCommand status took 10 milliseconds Oct 21 05:02:10 yhb-volumio volumio[6129]: info: sendMpdCommand clear took 8 milliseconds Oct 21 05:02:10 yhb-volumio volumio[6129]: info: sendMpdCommand status took 7 milliseconds Oct 21 05:02:10 yhb-volumio volumio[6129]: info: sendMpdCommand status took 4 milliseconds Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99596973" Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:10 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ------------------------------ 45ms Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ------------------------------ 44ms Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Oct 21 05:02:10 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Oct 21 05:02:10 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:10 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:10 yhb-volumio volumio[6129]: error: updateQueue error: null Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ------------------------------ 46ms Oct 21 05:02:10 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 43 milliseconds Oct 21 05:02:10 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:10 yhb-volumio volumio[6129]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 21 05:02:10 yhb-volumio volumio[6129]: info: ------------------------------ 59ms Oct 21 05:02:11 yhb-volumio volumio[6129]: info: Oct 21 05:02:11 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:11 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:11 yhb-volumio volumio[6129]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99596973" took 565 milliseconds Oct 21 05:02:11 yhb-volumio volumio[6129]: info: ------------------------------ 528ms Oct 21 05:02:11 yhb-volumio volumio[6129]: info: ------------------------------ 524ms Oct 21 05:02:11 yhb-volumio volumio[6129]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 21 05:02:11 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand play Oct 21 05:02:11 yhb-volumio volumio[6129]: info: Oct 21 05:02:11 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:11 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:11 yhb-volumio volumio[6129]: info: Oct 21 05:02:11 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:11 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:11 yhb-volumio volumio[6129]: info: ------------------------------ 5ms Oct 21 05:02:11 yhb-volumio volumio[6129]: info: sendMpdCommand play took 3 milliseconds Oct 21 05:02:11 yhb-volumio volumio[6129]: info: ------------------------------ 4ms Oct 21 05:02:11 yhb-volumio volumio[6129]: info: ------------------------------ 3ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand status took 370 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand status took 369 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand status took 365 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 4ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand status took 3 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus stop Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 381ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Oct 21 05:02:20 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 6ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand status took 5 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 4ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand status took 4 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":603,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":603,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 460ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 459ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 96ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 82 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 82 milliseconds Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:20 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:20 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 137ms Oct 21 05:02:20 yhb-volumio volumio[6129]: info: ------------------------------ 135ms Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Oct 21 05:02:22 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Oct 21 05:02:22 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Oct 21 05:02:22 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Oct 21 05:02:22 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ------------------------------ 8ms Oct 21 05:02:22 yhb-volumio volumio[6129]: info: sendMpdCommand status took 8 milliseconds Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ------------------------------ 8ms Oct 21 05:02:22 yhb-volumio volumio[6129]: info: sendMpdCommand status took 4 milliseconds Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Oct 21 05:02:22 yhb-volumio volumio[6129]: ---------------------------- MPD announces system playlist update Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Ignoring MPD Status Update Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Oct 21 05:02:22 yhb-volumio volumio[6129]: ---------------------------- MPD announces state update: player Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ControllerMpd::getState Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand status Oct 21 05:02:22 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 21 05:02:22 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ------------------------------ 3ms Oct 21 05:02:22 yhb-volumio volumio[6129]: info: sendMpdCommand status took 2 milliseconds Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseState Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"Linet-Adinisenkoy","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"Linet-Adinisenkoy","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ------------------------------ 52ms Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ------------------------------ 51ms Oct 21 05:02:22 yhb-volumio volumio[6129]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: ControllerMpd::parseTrackInfo Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ControllerMpd::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::servicePushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CorePlayQueue::getTrack 0 Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"69 Kbps","isStreaming":false,"title":"Linet-Adinisenkoy","artist":"Radyo Arabesk Alemi","album":null,"uri":"https://panel.radyomhd.com:9300/","trackType":"com:9300/"} Oct 21 05:02:22 yhb-volumio volumio[6129]: verbose: CURRENT POSITION 0 Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState stateService play Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::syncState currentStatus play Oct 21 05:02:22 yhb-volumio volumio[6129]: info: Received an update from plugin. extracting info from payload Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreStateMachine::pushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: CoreCommandRouter::volumioPushState Oct 21 05:02:22 yhb-volumio volumio[6129]: info: ------------------------------ 66ms Oct 21 05:02:27 yhb-volumio volumiologrotate[788]: ls: cannot access '/var/log/samba/log.wb-YHB': No such file or directory Oct 21 05:02:27 yhb-volumio volumiologrotate[788]: ls: cannot access 'VOLUMIO': No such file or directory Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 21 05:02:36 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 21 05:02:59 yhb-volumio volumio[6129]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 21 05:03:00 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 21 05:03:00 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 21 05:03:00 yhb-volumio sudo[7928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 21 05:03:00 yhb-volumio sudo[7928]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 05:03:00 yhb-volumio sudo[7932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 21 05:03:00 yhb-volumio sudo[7932]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 05:03:00 yhb-volumio sudo[7939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 21 05:03:00 yhb-volumio sudo[7939]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 05:03:00 yhb-volumio sudo[7932]: pam_unix(sudo:session): session closed for user root Oct 21 05:03:00 yhb-volumio sudo[7928]: pam_unix(sudo:session): session closed for user root Oct 21 05:03:00 yhb-volumio sudo[7945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 21 05:03:00 yhb-volumio sudo[7939]: pam_unix(sudo:session): session closed for user root Oct 21 05:03:00 yhb-volumio sudo[7945]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 05:03:00 yhb-volumio sudo[7945]: pam_unix(sudo:session): session closed for user root Oct 21 05:03:00 yhb-volumio sudo[7954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 21 05:03:00 yhb-volumio sudo[7954]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 05:03:00 yhb-volumio sudo[7954]: pam_unix(sudo:session): session closed for user root Oct 21 05:03:00 yhb-volumio sudo[7956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 21 05:03:00 yhb-volumio sudo[7956]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 05:03:00 yhb-volumio sudo[7956]: pam_unix(sudo:session): session closed for user root Oct 21 05:03:00 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 21 05:03:00 yhb-volumio volumio[6129]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 21 05:03:00 yhb-volumio sudo[7962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 21 05:03:00 yhb-volumio sudo[7962]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 05:03:04 yhb-volumio sudo[7962]: pam_unix(sudo:session): session closed for user root Oct 21 05:03:13 yhb-volumio volumio[6129]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 21 05:03:13 yhb-volumio volumio[6129]: Error: connect ETIMEDOUT 210.56.51.192:80 Oct 21 05:03:13 yhb-volumio volumio[6129]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 21 05:03:13 yhb-volumio volumio[6129]: errno: -110, Oct 21 05:03:13 yhb-volumio volumio[6129]: code: 'ETIMEDOUT', Oct 21 05:03:13 yhb-volumio volumio[6129]: syscall: 'connect', Oct 21 05:03:13 yhb-volumio volumio[6129]: address: '210.56.51.192', Oct 21 05:03:13 yhb-volumio volumio[6129]: port: 80 Oct 21 05:03:13 yhb-volumio volumio[6129]: } Oct 21 05:03:13 yhb-volumio volumio[6129]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 21 05:03:14 yhb-volumio sudo[7976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-21 05:02 Oct 21 05:03:14 yhb-volumio sudo[7976]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"