-- Logs begin at Tue 2026-04-07 04:36:41 UTC, end at Fri 2026-04-10 19:04:03 UTC. -- Apr 10 19:03:42 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 10 19:03:42 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 19:03:44 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::ClearQueue Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::stop Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::stPlaybackTimer Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::updateTrackBlock Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrackBlock Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::serviceStop Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::serviceStop Apr 10 19:03:47 volumio volumio[831]: info: [1775847827304] ControllerWebradio::stop Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::clearPlayQueue Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::saveQueue Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::volumioPushQueue Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::addQueueItems Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::addQueueItems Apr 10 19:03:47 volumio volumio[831]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::saveQueue Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::volumioPushQueue Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::updateTrackBlock Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrackBlock Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::volumioPlay Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::play index 0 Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::stop Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::play index undefined Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::startPlaybackTimer Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:47 volumio volumio[831]: info: [1775847827324] ControllerWebradio::clearAddPlayTrack Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 19:03:47 volumio volumio[831]: info: Apr 10 19:03:47 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand stop took 67 milliseconds Apr 10 19:03:47 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand stop took 49 milliseconds Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 19:03:47 volumio volumio[831]: info: Apr 10 19:03:47 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:47 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:47 volumio volumio[831]: info: Apr 10 19:03:47 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:47 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand status took 12 milliseconds Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand clear took 7 milliseconds Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand status took 6 milliseconds Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:47 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:47 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:47 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:47 volumio volumio[831]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 10 19:03:47 volumio volumio[831]: info: ------------------------------ 18ms Apr 10 19:03:47 volumio volumio[831]: info: Apr 10 19:03:47 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:47 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:47 volumio volumio[831]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 10 19:03:47 volumio volumio[831]: error: updateQueue error: null Apr 10 19:03:47 volumio volumio[831]: info: ------------------------------ 26ms Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:47 volumio volumio[831]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 19:03:47 volumio volumio[831]: info: ------------------------------ 40ms Apr 10 19:03:47 volumio volumio[831]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 10 19:03:47 volumio volumio[831]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 10 19:03:47 volumio volumio[831]: info: Apr 10 19:03:47 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:47 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 487 milliseconds Apr 10 19:03:47 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 10 19:03:47 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand play Apr 10 19:03:47 volumio volumio[831]: info: ------------------------------ 476ms Apr 10 19:03:47 volumio volumio[831]: info: ------------------------------ 2ms Apr 10 19:03:47 volumio volumio[831]: info: Apr 10 19:03:47 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:47 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:47 volumio volumio[831]: info: sendMpdCommand play took 4 milliseconds Apr 10 19:03:47 volumio volumio[831]: info: ------------------------------ 3ms Apr 10 19:03:51 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 13 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 13 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 2 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: 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":"antenne","artist":"(#1 - 4908/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus stop Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 28ms Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 4 milliseconds Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: 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":"antenne","artist":"(#1 - 4908/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:51 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: 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":"antenne","artist":"(#1 - 4908/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:51 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 69ms Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 60ms Apr 10 19:03:51 volumio volumio[831]: info: [LastFM] Current track has sufficient metadata: title (ANTENNE BAYERN) and artist ((#1 - 4908/500000) ANTENNE BAYERN) passed on explicitly Apr 10 19:03:51 volumio volumio[831]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 65 milliseconds Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: 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":"antenne","artist":"(#1 - 4908/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:51 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 90ms Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:51 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:51 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 4ms Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 4 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 3ms Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 2 milliseconds Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:51 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:51 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 27ms Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 27ms Apr 10 19:03:51 volumio volumio[831]: info: [LastFM] Split composite title into artist: ANTENNE BAYERN and title: Nachrichten Apr 10 19:03:51 volumio volumio[831]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:51 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:51 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:51 volumio volumio[831]: info: Apr 10 19:03:51 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 5ms Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 4 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 4ms Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand status took 3 milliseconds Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 10 19:03:51 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:51 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:51 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:51 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:51 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:51 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 25ms Apr 10 19:03:51 volumio volumio[831]: info: ------------------------------ 24ms Apr 10 19:03:52 volumio volumio[831]: info: Apr 10 19:03:52 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:52 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:52 volumio volumio[831]: info: Apr 10 19:03:52 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:52 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:52 volumio volumio[831]: info: Apr 10 19:03:52 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:52 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:52 volumio volumio[831]: info: Apr 10 19:03:52 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:52 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:52 volumio volumio[831]: info: ------------------------------ 7ms Apr 10 19:03:52 volumio volumio[831]: info: sendMpdCommand status took 5 milliseconds Apr 10 19:03:52 volumio volumio[831]: info: ------------------------------ 5ms Apr 10 19:03:52 volumio volumio[831]: info: sendMpdCommand status took 3 milliseconds Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:52 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 10 19:03:52 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:52 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:52 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:52 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:52 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:52 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:52 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:52 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:52 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:52 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:52 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:52 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:52 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:52 volumio volumio[831]: info: ------------------------------ 33ms Apr 10 19:03:52 volumio volumio[831]: info: ------------------------------ 31ms Apr 10 19:03:53 volumio volumio[831]: info: Apr 10 19:03:53 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:53 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:53 volumio volumio[831]: info: Apr 10 19:03:53 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:53 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:53 volumio volumio[831]: info: Apr 10 19:03:53 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:53 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:53 volumio volumio[831]: info: Apr 10 19:03:53 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:53 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:53 volumio volumio[831]: info: ------------------------------ 3ms Apr 10 19:03:53 volumio volumio[831]: info: sendMpdCommand status took 3 milliseconds Apr 10 19:03:53 volumio volumio[831]: info: ------------------------------ 3ms Apr 10 19:03:53 volumio volumio[831]: info: sendMpdCommand status took 2 milliseconds Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:53 volumio volumio[831]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 10 19:03:53 volumio volumio[831]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:53 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:53 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:53 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:53 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3283,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:53 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:53 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:53 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:53 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:53 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3283,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - Nachrichten","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 10 19:03:53 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:03:53 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:53 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:53 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:53 volumio volumio[831]: info: ------------------------------ 27ms Apr 10 19:03:53 volumio volumio[831]: info: ------------------------------ 26ms Apr 10 19:03:56 volumio volumio[831]: info: VolumeController::SetAlsaVolume75 Apr 10 19:03:56 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Apr 10 19:03:56 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:56 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:56 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::ClearQueue Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::stop Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::stPlaybackTimer Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::updateTrackBlock Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrackBlock Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::serviceStop Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::serviceStop Apr 10 19:03:59 volumio volumio[831]: info: [1775847839853] ControllerWebradio::stop Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::clearPlayQueue Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::saveQueue Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::volumioPushQueue Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::addQueueItems Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::addQueueItems Apr 10 19:03:59 volumio volumio[831]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::saveQueue Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::volumioPushQueue Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::updateTrackBlock Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrackBlock Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::volumioPlay Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::play index 0 Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::stop Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::play index undefined Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::startPlaybackTimer Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:59 volumio volumio[831]: info: [1775847839869] ControllerWebradio::clearAddPlayTrack Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 19:03:59 volumio volumio[831]: info: Apr 10 19:03:59 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:59 volumio volumio[831]: info: sendMpdCommand stop took 72 milliseconds Apr 10 19:03:59 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:59 volumio volumio[831]: info: sendMpdCommand stop took 56 milliseconds Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 19:03:59 volumio volumio[831]: info: Apr 10 19:03:59 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:03:59 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:03:59 volumio volumio[831]: info: Apr 10 19:03:59 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:59 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:59 volumio volumio[831]: info: sendMpdCommand status took 9 milliseconds Apr 10 19:03:59 volumio volumio[831]: info: sendMpdCommand clear took 9 milliseconds Apr 10 19:03:59 volumio volumio[831]: info: sendMpdCommand status took 7 milliseconds Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:03:59 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:03:59 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:03:59 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:03:59 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:03:59 volumio volumio[831]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 10 19:03:59 volumio volumio[831]: info: ------------------------------ 23ms Apr 10 19:03:59 volumio volumio[831]: info: Apr 10 19:03:59 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:03:59 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:03:59 volumio volumio[831]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 10 19:03:59 volumio volumio[831]: error: updateQueue error: null Apr 10 19:03:59 volumio volumio[831]: info: ------------------------------ 30ms Apr 10 19:03:59 volumio volumio[831]: info: sendMpdCommand playlistinfo took 27 milliseconds Apr 10 19:03:59 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:03:59 volumio volumio[831]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 19:03:59 volumio volumio[831]: info: ------------------------------ 41ms Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 131 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand play Apr 10 19:04:00 volumio volumio[831]: info: Apr 10 19:04:00 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:04:00 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:04:00 volumio volumio[831]: info: ------------------------------ 116ms Apr 10 19:04:00 volumio volumio[831]: info: Apr 10 19:04:00 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:04:00 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand play took 6 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: ------------------------------ 5ms Apr 10 19:04:00 volumio volumio[831]: info: ------------------------------ 3ms Apr 10 19:04:00 volumio volumio[831]: info: Apr 10 19:04:00 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:00 volumio volumio[831]: info: Apr 10 19:04:00 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:00 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Apr 10 19:04:00 volumio volumio[831]: info: Apr 10 19:04:00 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand status took 15 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand status took 14 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:00 volumio volumio[831]: info: Apr 10 19:04:00 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand status took 2 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand status took 2 milliseconds Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:00 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:00 volumio volumio[831]: 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":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:00 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus stop Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:00 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:00 volumio volumio[831]: 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":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:00 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:04:00 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:00 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:00 volumio volumio[831]: info: ------------------------------ 42ms Apr 10 19:04:00 volumio volumio[831]: info: ------------------------------ 42ms Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 10 19:04:00 volumio volumio[831]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:00 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:00 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:00 volumio volumio[831]: 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":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:00 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:04:00 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:00 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:00 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:00 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:00 volumio volumio[831]: 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":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:00 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:04:00 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:00 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:00 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:00 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:00 volumio volumio[831]: info: ------------------------------ 67ms Apr 10 19:04:00 volumio volumio[831]: info: ------------------------------ 66ms Apr 10 19:04:00 volumio volumio[831]: info: [LastFM] Current track has sufficient metadata: title (Dance Wave!) and artist ((#1 - 5518/32000) Dance Wave!) passed on explicitly Apr 10 19:04:00 volumio volumio[831]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:04:01 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:04:01 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:04:01 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 6ms Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand status took 5 milliseconds Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 4ms Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand status took 3 milliseconds Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces system playlist update Apr 10 19:04:01 volumio volumio[831]: info: Ignoring MPD Status Update Apr 10 19:04:01 volumio volumio[831]: info: Apr 10 19:04:01 volumio volumio[831]: ---------------------------- MPD announces state update: player Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::getState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 6ms Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand status took 5 milliseconds Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 3ms Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand status took 2 milliseconds Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseState Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:01 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:01 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:01 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:04:01 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:01 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:01 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:01 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:04:01 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 32ms Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 32ms Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 10 19:04:01 volumio volumio[831]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:01 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:01 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:01 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:01 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:04:01 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: ControllerMpd::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::servicePushState Apr 10 19:04:01 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Apr 10 19:04:01 volumio volumio[831]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 10 19:04:01 volumio volumio[831]: verbose: CURRENT POSITION 0 Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState stateService play Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus play Apr 10 19:04:01 volumio volumio[831]: info: Received an update from plugin. extracting info from payload Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: CoreStateMachine::pushState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 67ms Apr 10 19:04:01 volumio volumio[831]: info: ------------------------------ 64ms Apr 10 19:04:01 volumio volumio[831]: info: [LastFM] Current track has sufficient metadata: title (All about Dance from 2000 till today!) and artist (Dance Wave!) passed on explicitly Apr 10 19:04:01 volumio volumio[831]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 10 19:04:01 volumio volumio[831]: info: Discovery: Getting this device information Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 10 19:04:01 volumio volumio[831]: verbose: New Socket.io Connection to 192.168.0.9:3000 from 192.168.0.6 UA: Dart/3.10 (dart:io) Total Clients: 9 Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 10 19:04:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 10 19:04:02 volumio volumio[831]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 19:04:02 volumio volumio[831]: TypeError: Cannot read property 'slice' of null Apr 10 19:04:02 volumio volumio[831]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:714:41) Apr 10 19:04:02 volumio volumio[831]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:724:7) Apr 10 19:04:02 volumio volumio[831]: at Object.onceWrapper (events.js:422:26) Apr 10 19:04:02 volumio volumio[831]: at ClientRequest.emit (events.js:315:20) Apr 10 19:04:02 volumio volumio[831]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Apr 10 19:04:02 volumio volumio[831]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Apr 10 19:04:02 volumio volumio[831]: at TLSSocket.socketOnData (_http_client.js:509:22) Apr 10 19:04:02 volumio volumio[831]: at TLSSocket.emit (events.js:315:20) Apr 10 19:04:02 volumio volumio[831]: at addChunk (internal/streams/readable.js:309:12) Apr 10 19:04:02 volumio volumio[831]: at readableAddChunk (internal/streams/readable.js:284:9) Apr 10 19:04:02 volumio volumio[831]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Apr 10 19:04:02 volumio volumio[831]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Apr 10 19:04:02 volumio volumio[831]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 19:04:03 volumio sudo[28893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-10 19:03 Apr 10 19:04:03 volumio sudo[28893]: 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"