-- Logs begin at Sat 2025-04-26 07:47:38 CEST, end at Sun 2025-04-27 10:34:28 CEST. -- Apr 27 10:33:05 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:33:08 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::ClearQueue Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::stPlaybackTimer Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::serviceStop Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::serviceStop Apr 27 10:33:08 volumio volumio[26852]: info: [1745742788651] ControllerWebradio::stop Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::clearPlayQueue Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::addQueueItems Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::addQueueItems Apr 27 10:33:08 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:33:08 volumio volumio[26852]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99503700 Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:33:08 volumio volumio[26852]: info: CoreCommandRouter::volumioPlay Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::play index 0 Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::play index undefined Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::startPlaybackTimer Apr 27 10:33:08 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:08 volumio volumio[26852]: info: [1745742788661] ControllerWebradio::clearAddPlayTrack Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:33:08 volumio volumio[26852]: info: sendMpdCommand stop took 110 milliseconds Apr 27 10:33:08 volumio volumio[26852]: info: Apr 27 10:33:08 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:08 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:08 volumio volumio[26852]: info: sendMpdCommand stop took 102 milliseconds Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 10:33:08 volumio volumio[26852]: info: Apr 27 10:33:08 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:33:08 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:33:08 volumio volumio[26852]: info: sendMpdCommand status took 2 milliseconds Apr 27 10:33:08 volumio volumio[26852]: info: sendMpdCommand clear took 1 milliseconds Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99503700" Apr 27 10:33:08 volumio volumio[26852]: error: updateQueue error: null Apr 27 10:33:08 volumio volumio[26852]: info: ------------------------------ 3ms Apr 27 10:33:08 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:08 volumio volumio[26852]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 27 10:33:08 volumio volumio[26852]: info: ------------------------------ 7ms Apr 27 10:33:08 volumio volumio[26852]: info: Apr 27 10:33:08 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:33:08 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:33:08 volumio volumio[26852]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99503700" took 90 milliseconds Apr 27 10:33:08 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 27 10:33:08 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand play Apr 27 10:33:08 volumio volumio[26852]: info: ------------------------------ 2ms Apr 27 10:33:08 volumio volumio[26852]: info: sendMpdCommand play took 1 milliseconds Apr 27 10:33:11 volumio volumio[26852]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%208%2F150)%20Oldies%20Online%20Radio%20320%20KBS%20High%20Quality/0f56f9ac-3264-43a7-8ba4-885e73eb6a60.jpg' Apr 27 10:33:13 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:33:15 volumio volumio[26852]: info: Apr 27 10:33:15 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:15 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:15 volumio volumio[26852]: info: Apr 27 10:33:15 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:15 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:33:15 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:15 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:15 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:33:15 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:15 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:15 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:33:15 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:33:15 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:15 volumio volumio[26852]: 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":null,"isStreaming":false,"title":"320kbps","artist":"(#1 - 1/400) Snakeice's House of Beats 320kbps","album":null,"uri":"http://99.33.118.33:8000/320kbps","trackType":""} Apr 27 10:33:15 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:33:15 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:33:15 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:33:15 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:33:15 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:33:15 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:15 volumio volumio[26852]: 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":null,"isStreaming":false,"title":"320kbps","artist":"(#1 - 1/400) Snakeice's House of Beats 320kbps","album":null,"uri":"http://99.33.118.33:8000/320kbps","trackType":""} Apr 27 10:33:15 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:33:15 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:33:15 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:33:15 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:33:15 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 10:33:15 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:15 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:15 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:33:15 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:15 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:15 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:15 volumio volumio[26852]: info: ------------------------------ 8ms Apr 27 10:33:15 volumio volumio[26852]: info: ------------------------------ 8ms Apr 27 10:33:16 volumio volumio[26852]: Searching plugin music_service/webradio Apr 27 10:33:16 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , search Apr 27 10:33:16 volumio volumio[26852]: info: All search sources collected, pushing search results Apr 27 10:33:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 10:33:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 10:33:18 volumio volumio[26852]: info: Discovery: Getting this device information Apr 27 10:33:18 volumio volumio[26852]: info: CoreCommandRouter::volumioGetState Apr 27 10:33:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 10:33:20 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:33:21 volumio volumio[26852]: info: Apr 27 10:33:21 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:33:21 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:33:21 volumio volumio[26852]: info: Apr 27 10:33:21 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:21 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:21 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:21 volumio volumio[26852]: info: ------------------------------ 2ms Apr 27 10:33:21 volumio volumio[26852]: info: sendMpdCommand status took 2 milliseconds Apr 27 10:33:21 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:21 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:21 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 27 10:33:21 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:21 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:33:21 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:33:21 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:21 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Alicia Keys - Fire We Make (Feat. Maxwell)","artist":"Snakeice's House of Beats 320kbps","album":null,"uri":"http://99.33.118.33:8000/320kbps","trackType":""} Apr 27 10:33:21 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:33:21 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:33:21 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:33:21 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:33:21 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 10:33:21 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:21 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:33:21 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:21 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:21 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:21 volumio volumio[26852]: info: ------------------------------ 11ms Apr 27 10:33:23 volumio volumio[26852]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%201%2F400)%20Snakeice's%20House%20of%20Beats%20320kbps/7b3c11ed-ef17-4ff2-99e7-9a8aa93de16f.jpg' Apr 27 10:33:27 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::ClearQueue Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::stPlaybackTimer Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::serviceStop Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::serviceStop Apr 27 10:33:27 volumio volumio[26852]: info: [1745742807361] ControllerWebradio::stop Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::clearPlayQueue Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::addQueueItems Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::addQueueItems Apr 27 10:33:27 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:33:27 volumio volumio[26852]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99489640 Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::volumioPlay Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::play index 0 Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::play index undefined Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::startPlaybackTimer Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:27 volumio volumio[26852]: info: [1745742807367] ControllerWebradio::clearAddPlayTrack Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand stop took 101 milliseconds Apr 27 10:33:27 volumio volumio[26852]: info: Apr 27 10:33:27 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:27 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand stop took 96 milliseconds Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 10:33:27 volumio volumio[26852]: info: Apr 27 10:33:27 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:33:27 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand clear took 1 milliseconds Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99489640" Apr 27 10:33:27 volumio volumio[26852]: error: updateQueue error: null Apr 27 10:33:27 volumio volumio[26852]: info: ------------------------------ 2ms Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:27 volumio volumio[26852]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 27 10:33:27 volumio volumio[26852]: info: ------------------------------ 4ms Apr 27 10:33:27 volumio volumio[26852]: info: Apr 27 10:33:27 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:33:27 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99489640" took 89 milliseconds Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand play Apr 27 10:33:27 volumio volumio[26852]: info: ------------------------------ 1ms Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand play took 0 milliseconds Apr 27 10:33:27 volumio volumio[26852]: info: Apr 27 10:33:27 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:27 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:27 volumio volumio[26852]: info: Apr 27 10:33:27 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand status took 4 milliseconds Apr 27 10:33:27 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:27 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:27 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radioblues-flac","artist":"(#1 - 12/512) Radio BluesFlac","album":null,"uri":"https://streams.radiomast.io:443/radioblues-flac","trackType":""} Apr 27 10:33:27 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:33:27 volumio volumio[26852]: info: ------------------------------ 11ms Apr 27 10:33:27 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 27 10:33:27 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:27 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:27 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radioblues-flac","artist":"(#1 - 12/512) Radio BluesFlac","album":null,"uri":"https://streams.radiomast.io:443/radioblues-flac","trackType":""} Apr 27 10:33:27 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:33:27 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:27 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:27 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:27 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:27 volumio volumio[26852]: info: ------------------------------ 19ms Apr 27 10:33:28 volumio volumio[26852]: info: Apr 27 10:33:28 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:33:28 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:33:28 volumio volumio[26852]: info: Apr 27 10:33:28 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:28 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:28 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:28 volumio volumio[26852]: info: ------------------------------ 3ms Apr 27 10:33:28 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:33:28 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:28 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:28 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:33:28 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:28 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:33:28 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:33:28 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:28 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radioblues-flac","artist":"Radio Bluesflac","album":null,"uri":"https://streams.radiomast.io:443/radioblues-flac","trackType":""} Apr 27 10:33:28 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:33:28 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:33:28 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:33:28 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:33:28 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 10:33:28 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:28 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:28 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:33:28 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:28 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:28 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:28 volumio volumio[26852]: info: ------------------------------ 12ms Apr 27 10:33:28 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:33:33 volumio volumio[26852]: info: Apr 27 10:33:33 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:33:33 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:33:33 volumio volumio[26852]: info: Apr 27 10:33:33 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:33:33 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:33:33 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:33:33 volumio volumio[26852]: info: ------------------------------ 4ms Apr 27 10:33:33 volumio volumio[26852]: info: sendMpdCommand status took 2 milliseconds Apr 27 10:33:33 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:33:33 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:33:33 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:33:33 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:33:33 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:33:33 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:33:33 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:33:33 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5965,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Smokin' Joe Kubek Band Bnois King - If It's The Last Thing I Do | Mixxx","artist":"Radio Bluesflac","album":null,"uri":"https://streams.radiomast.io:443/radioblues-flac","trackType":""} Apr 27 10:33:33 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:33:33 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:33:33 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:33:33 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:33:33 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 27 10:33:33 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:33 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:33:33 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:33 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:33:33 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:33:33 volumio volumio[26852]: info: ------------------------------ 13ms Apr 27 10:33:35 volumio volumio[26852]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%2012%2F512)%20Radio%20BluesFlac/8259084e-c98e-49ae-9e3e-f537af8e3908.jpg' Apr 27 10:33:35 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:33:41 volumio volumio[26852]: Searching plugin music_service/webradio Apr 27 10:33:41 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , search Apr 27 10:33:42 volumio volumio[26852]: info: All search sources collected, pushing search results Apr 27 10:33:43 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:33:48 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 10:33:48 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 10:33:48 volumio volumio[26852]: info: Discovery: Getting this device information Apr 27 10:33:48 volumio volumio[26852]: info: CoreCommandRouter::volumioGetState Apr 27 10:33:48 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 10:33:49 volumio volumio[26852]: Searching plugin music_service/webradio Apr 27 10:33:49 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , search Apr 27 10:33:49 volumio volumio[26852]: (node:26852) UnhandledPromiseRejectionWarning: Error: Start tag expected, '<' not found Apr 27 10:33:49 volumio volumio[26852]: at Object.module.exports.fromXml (/volumio/node_modules/libxmljs/lib/document.js:168:21) Apr 27 10:33:49 volumio volumio[26852]: at /volumio/app/plugins/music_service/webradio/index.js:962:31 Apr 27 10:33:49 volumio volumio[26852]: at runMicrotasks () Apr 27 10:33:49 volumio volumio[26852]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 27 10:33:49 volumio volumio[26852]: (Use `node --trace-warnings ...` to show where the warning was created) Apr 27 10:33:49 volumio volumio[26852]: (node:26852) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Apr 27 10:33:49 volumio volumio[26852]: (node:26852) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Apr 27 10:33:51 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:33:58 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:34:00 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 27 10:34:00 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:01 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 27 10:34:01 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:06 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:34:11 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::ClearQueue Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::stPlaybackTimer Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::serviceStop Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::serviceStop Apr 27 10:34:11 volumio volumio[26852]: info: [1745742851424] ControllerWebradio::stop Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::clearPlayQueue Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::addQueueItems Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::addQueueItems Apr 27 10:34:11 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:11 volumio volumio[26852]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s267625 Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 27 10:34:11 volumio volumio[26852]: info: Apr 27 10:34:11 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:11 volumio volumio[26852]: info: sendMpdCommand stop took 129 milliseconds Apr 27 10:34:11 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:11 volumio volumio[26852]: info: sendMpdCommand status took 0 milliseconds Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:11 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:11 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: 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":"The Smokin' Joe Kubek Band Bnois King - If It's The Last Thing I Do | Mixxx","artist":"Radio Bluesflac","album":null,"uri":"https://streams.radiomast.io:443/radioblues-flac","trackType":""} Apr 27 10:34:11 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::syncState stateService stop Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:11 volumio volumio[26852]: info: No code Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:11 volumio volumio[26852]: info: ------------------------------ 15ms Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:34:11 volumio volumio[26852]: info: CoreCommandRouter::volumioPlay Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::play index 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::play index undefined Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: info: CoreStateMachine::startPlaybackTimer Apr 27 10:34:11 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:11 volumio volumio[26852]: info: [1745742851650] ControllerWebradio::clearAddPlayTrack Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:34:11 volumio volumio[26852]: info: sendMpdCommand stop took 1 milliseconds Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 10:34:11 volumio volumio[26852]: info: Apr 27 10:34:11 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:11 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:11 volumio volumio[26852]: info: sendMpdCommand clear took 1 milliseconds Apr 27 10:34:11 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand load "https://nr8.newradio.it:19574/stream" Apr 27 10:34:11 volumio volumio[26852]: error: updateQueue error: null Apr 27 10:34:11 volumio volumio[26852]: info: ------------------------------ 2ms Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand add "https://nr8.newradio.it:19574/stream" Apr 27 10:34:12 volumio volumio[26852]: info: Apr 27 10:34:12 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:12 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand add "https://nr8.newradio.it:19574/stream" took 2 milliseconds Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand play Apr 27 10:34:12 volumio volumio[26852]: info: ------------------------------ 3ms Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand play took 1 milliseconds Apr 27 10:34:12 volumio volumio[26852]: info: Apr 27 10:34:12 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:12 volumio volumio[26852]: info: Apr 27 10:34:12 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand status took 25 milliseconds Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand status took 2 milliseconds Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:12 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:12 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://nr8.newradio.it:19574/stream","trackType":""} Apr 27 10:34:12 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:34:12 volumio volumio[26852]: info: ------------------------------ 32ms Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:12 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:12 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://nr8.newradio.it:19574/stream","trackType":""} Apr 27 10:34:12 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:12 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:12 volumio volumio[26852]: info: ------------------------------ 17ms Apr 27 10:34:12 volumio volumio[26852]: info: Apr 27 10:34:12 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:12 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:12 volumio volumio[26852]: info: Apr 27 10:34:12 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:12 volumio volumio[26852]: info: Apr 27 10:34:12 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:12 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:12 volumio volumio[26852]: info: Apr 27 10:34:12 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:12 volumio volumio[26852]: info: ------------------------------ 5ms Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand status took 4 milliseconds Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:12 volumio volumio[26852]: info: ------------------------------ 5ms Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand status took 3 milliseconds Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:12 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:12 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Michael Jackson - Man in the mirror - 1987 ","artist":"NR8","album":null,"uri":"https://nr8.newradio.it:19574/stream","trackType":""} Apr 27 10:34:12 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:12 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:12 volumio volumio[26852]: info: ------------------------------ 17ms Apr 27 10:34:12 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 27 10:34:12 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:12 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:12 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:12 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Michael Jackson - Man in the mirror - 1987 ","artist":"NR8","album":null,"uri":"https://nr8.newradio.it:19574/stream","trackType":""} Apr 27 10:34:12 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:12 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:12 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:12 volumio volumio[26852]: info: ------------------------------ 22ms Apr 27 10:34:13 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:34:15 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:15 volumio volumio[26852]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::ClearQueue Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::stPlaybackTimer Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:34:15 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:15 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:15 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:15 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::serviceStop Apr 27 10:34:15 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:15 volumio volumio[26852]: info: CoreCommandRouter::serviceStop Apr 27 10:34:15 volumio volumio[26852]: info: [1745742855958] ControllerWebradio::stop Apr 27 10:34:15 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:34:15 volumio volumio[26852]: info: CorePlayQueue::clearPlayQueue Apr 27 10:34:15 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:34:15 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:34:15 volumio volumio[26852]: info: CoreStateMachine::addQueueItems Apr 27 10:34:15 volumio volumio[26852]: info: CorePlayQueue::addQueueItems Apr 27 10:34:15 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:15 volumio volumio[26852]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s204567 Apr 27 10:34:15 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand stop took 84 milliseconds Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: 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":"Michael Jackson - Man in the mirror - 1987 ","artist":"NR8","album":null,"uri":"https://nr8.newradio.it:19574/stream","trackType":""} Apr 27 10:34:16 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState stateService stop Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: No code Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 17ms Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPlay Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::play index 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::play index undefined Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::startPlaybackTimer Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: info: [1745742856188] ControllerWebradio::clearAddPlayTrack Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand stop took 2 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:16 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand clear took 2 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand load "http://88.99.195.180:8015/stream" Apr 27 10:34:16 volumio volumio[26852]: error: updateQueue error: null Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 3ms Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand add "http://88.99.195.180:8015/stream" Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:16 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand add "http://88.99.195.180:8015/stream" took 2 milliseconds Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand play Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 2ms Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand play took 2 milliseconds Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand status took 24 milliseconds Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: 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":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://88.99.195.180:8015/stream","trackType":""} Apr 27 10:34:16 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 32ms Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: 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":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://88.99.195.180:8015/stream","trackType":""} Apr 27 10:34:16 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:16 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 16ms Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:16 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:16 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:16 volumio volumio[26852]: info: Apr 27 10:34:16 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 5ms Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand status took 3 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 4ms Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand status took 3 milliseconds Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Industry - State Of The Nation","artist":"DISCONIGHT RADIO","album":null,"uri":"http://88.99.195.180:8015/stream","trackType":""} Apr 27 10:34:16 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:16 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 17ms Apr 27 10:34:16 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 27 10:34:16 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:16 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:16 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:16 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Industry - State Of The Nation","artist":"DISCONIGHT RADIO","album":null,"uri":"http://88.99.195.180:8015/stream","trackType":""} Apr 27 10:34:16 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:16 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:16 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:16 volumio volumio[26852]: info: ------------------------------ 22ms Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 10:34:18 volumio volumio[26852]: info: Discovery: Getting this device information Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioGetState Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 10:34:18 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::ClearQueue Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::stPlaybackTimer Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::serviceStop Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::serviceStop Apr 27 10:34:18 volumio volumio[26852]: info: [1745742858662] ControllerWebradio::stop Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::clearPlayQueue Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::addQueueItems Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::addQueueItems Apr 27 10:34:18 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:18 volumio volumio[26852]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s223154 Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 27 10:34:18 volumio volumio[26852]: info: Apr 27 10:34:18 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:18 volumio volumio[26852]: info: sendMpdCommand stop took 51 milliseconds Apr 27 10:34:18 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:18 volumio volumio[26852]: info: sendMpdCommand status took 4 milliseconds Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:18 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:18 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: 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":"Industry - State Of The Nation","artist":"DISCONIGHT RADIO","album":null,"uri":"http://88.99.195.180:8015/stream","trackType":""} Apr 27 10:34:18 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::syncState stateService stop Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:18 volumio volumio[26852]: info: No code Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:18 volumio volumio[26852]: info: ------------------------------ 18ms Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioPushQueue Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::saveQueue Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::updateTrackBlock Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrackBlock Apr 27 10:34:18 volumio volumio[26852]: info: CoreCommandRouter::volumioPlay Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::play index 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::stop Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::play index undefined Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: info: CoreStateMachine::startPlaybackTimer Apr 27 10:34:18 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:18 volumio volumio[26852]: info: [1745742858881] ControllerWebradio::clearAddPlayTrack Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand stop Apr 27 10:34:18 volumio volumio[26852]: info: sendMpdCommand stop took 2 milliseconds Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand clear Apr 27 10:34:18 volumio volumio[26852]: info: Apr 27 10:34:18 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:18 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:18 volumio volumio[26852]: info: sendMpdCommand clear took 2 milliseconds Apr 27 10:34:18 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand load "http://mediaserv33.live-streams.nl:8036" Apr 27 10:34:18 volumio volumio[26852]: error: updateQueue error: null Apr 27 10:34:18 volumio volumio[26852]: info: ------------------------------ 3ms Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" Apr 27 10:34:19 volumio volumio[26852]: info: Apr 27 10:34:19 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:19 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" took 2 milliseconds Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand play Apr 27 10:34:19 volumio volumio[26852]: info: ------------------------------ 2ms Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand play took 2 milliseconds Apr 27 10:34:19 volumio volumio[26852]: info: Apr 27 10:34:19 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:19 volumio volumio[26852]: info: Apr 27 10:34:19 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand status took 3 milliseconds Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand status took 1 milliseconds Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:19 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:19 volumio volumio[26852]: 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":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Apr 27 10:34:19 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus stop Apr 27 10:34:19 volumio volumio[26852]: info: ------------------------------ 11ms Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:19 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:19 volumio volumio[26852]: 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":null,"isStreaming":false,"title":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Apr 27 10:34:19 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:19 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:19 volumio volumio[26852]: info: ------------------------------ 16ms Apr 27 10:34:19 volumio volumio[26852]: info: Apr 27 10:34:19 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:19 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:19 volumio volumio[26852]: info: Apr 27 10:34:19 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:19 volumio volumio[26852]: info: Apr 27 10:34:19 volumio volumio[26852]: ---------------------------- MPD announces system playlist update Apr 27 10:34:19 volumio volumio[26852]: info: Ignoring MPD Status Update Apr 27 10:34:19 volumio volumio[26852]: info: Apr 27 10:34:19 volumio volumio[26852]: ---------------------------- MPD announces state update: player Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::getState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand status Apr 27 10:34:19 volumio volumio[26852]: info: ------------------------------ 6ms Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand status took 3 milliseconds Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:19 volumio volumio[26852]: info: ------------------------------ 4ms Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand status took 3 milliseconds Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseState Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:19 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:19 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"DJ Bool Presents Jerk House Connection - Mother Blues","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Apr 27 10:34:19 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:19 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:19 volumio volumio[26852]: info: ------------------------------ 17ms Apr 27 10:34:19 volumio volumio[26852]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 27 10:34:19 volumio volumio[26852]: verbose: ControllerMpd::parseTrackInfo Apr 27 10:34:19 volumio volumio[26852]: info: ControllerMpd::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::servicePushState Apr 27 10:34:19 volumio volumio[26852]: info: CorePlayQueue::getTrack 0 Apr 27 10:34:19 volumio volumio[26852]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"DJ Bool Presents Jerk House Connection - Mother Blues","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Apr 27 10:34:19 volumio volumio[26852]: verbose: CURRENT POSITION 0 Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState stateService play Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::syncState currentStatus play Apr 27 10:34:19 volumio volumio[26852]: info: Received an update from plugin. extracting info from payload Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreStateMachine::pushState Apr 27 10:34:19 volumio volumio[26852]: info: CoreCommandRouter::volumioPushState Apr 27 10:34:19 volumio volumio[26852]: info: ------------------------------ 22ms Apr 27 10:34:21 volumio wpa_supplicant[737]: wlan0: Failed to initiate sched scan Apr 27 10:34:25 volumio volumio[26852]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 27 10:34:26 volumio volumio[26852]: info: Preload queue cleared Apr 27 10:34:28 volumio volumio[26852]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 10:34:28 volumio volumio[26852]: Error: connect ETIMEDOUT 151.101.134.79:80 Apr 27 10:34:28 volumio volumio[26852]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 27 10:34:28 volumio volumio[26852]: errno: -110, Apr 27 10:34:28 volumio volumio[26852]: code: 'ETIMEDOUT', Apr 27 10:34:28 volumio volumio[26852]: syscall: 'connect', Apr 27 10:34:28 volumio volumio[26852]: address: '151.101.134.79', Apr 27 10:34:28 volumio volumio[26852]: port: 80 Apr 27 10:34:28 volumio volumio[26852]: } Apr 27 10:34:28 volumio volumio[26852]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 10:34:28 volumio sudo[27358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-27 10:33 Apr 27 10:34:28 volumio sudo[27358]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"