-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Mon 2025-04-21 22:50:16 CST. -- Apr 21 22:49:00 volumio volumio[3862]: info: Apr 21 22:49:00 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:00 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:00 volumio volumio[3862]: info: Apr 21 22:49:00 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:00 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:00 volumio volumio[3862]: info: Apr 21 22:49:00 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:00 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:00 volumio volumio[3862]: info: Apr 21 22:49:00 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:00 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:00 volumio volumio[3862]: info: Apr 21 22:49:00 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:00 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:00 volumio volumio[3862]: info: Apr 21 22:49:00 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:00 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:00 volumio volumio[3862]: info: ------------------------------ 22ms Apr 21 22:49:00 volumio volumio[3862]: info: sendMpdCommand status took 19 milliseconds Apr 21 22:49:00 volumio volumio[3862]: info: ------------------------------ 18ms Apr 21 22:49:00 volumio volumio[3862]: info: sendMpdCommand status took 15 milliseconds Apr 21 22:49:00 volumio volumio[3862]: info: ------------------------------ 13ms Apr 21 22:49:00 volumio volumio[3862]: info: sendMpdCommand status took 8 milliseconds Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:00 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 21 22:49:00 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:00 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:00 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:00 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:00 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:00 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":44280,"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 - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:00 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:00 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:00 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:00 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:00 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":44280,"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 - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:00 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:00 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:00 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:00 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:00 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":44280,"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 - Wir lieben Bayern, wir lieben Musik","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:00 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:00 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:00 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:00 volumio volumio[3862]: info: ------------------------------ 281ms Apr 21 22:49:00 volumio volumio[3862]: info: ------------------------------ 278ms Apr 21 22:49:00 volumio volumio[3862]: info: ------------------------------ 275ms Apr 21 22:49:01 volumio volumio[3862]: info: Apr 21 22:49:01 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:01 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:01 volumio volumio[3862]: info: Apr 21 22:49:01 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:01 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:01 volumio volumio[3862]: info: Apr 21 22:49:01 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:01 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:01 volumio volumio[3862]: info: Apr 21 22:49:01 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:01 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:01 volumio volumio[3862]: info: Apr 21 22:49:01 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:01 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:01 volumio volumio[3862]: info: Apr 21 22:49:01 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:01 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:01 volumio volumio[3862]: info: ------------------------------ 18ms Apr 21 22:49:01 volumio volumio[3862]: info: sendMpdCommand status took 14 milliseconds Apr 21 22:49:01 volumio volumio[3862]: info: ------------------------------ 13ms Apr 21 22:49:01 volumio volumio[3862]: info: sendMpdCommand status took 12 milliseconds Apr 21 22:49:01 volumio volumio[3862]: info: ------------------------------ 11ms Apr 21 22:49:01 volumio volumio[3862]: info: sendMpdCommand status took 9 milliseconds Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:01 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 21 22:49:01 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 21 22:49:01 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:01 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:01 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:01 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:01 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45209,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:01 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:01 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:01 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:01 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:01 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45209,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:01 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:01 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:01 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:01 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:01 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45209,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:01 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:01 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:01 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:01 volumio volumio[3862]: info: ------------------------------ 315ms Apr 21 22:49:01 volumio volumio[3862]: info: ------------------------------ 314ms Apr 21 22:49:01 volumio volumio[3862]: info: ------------------------------ 313ms Apr 21 22:49:02 volumio volumio[3862]: info: Apr 21 22:49:02 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:02 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:02 volumio volumio[3862]: info: Apr 21 22:49:02 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:02 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:02 volumio volumio[3862]: info: Apr 21 22:49:02 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:02 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:02 volumio volumio[3862]: info: Apr 21 22:49:02 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:02 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:02 volumio volumio[3862]: info: Apr 21 22:49:02 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:02 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:02 volumio volumio[3862]: info: Apr 21 22:49:02 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:02 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:02 volumio volumio[3862]: info: ------------------------------ 20ms Apr 21 22:49:02 volumio volumio[3862]: info: sendMpdCommand status took 17 milliseconds Apr 21 22:49:02 volumio volumio[3862]: info: ------------------------------ 16ms Apr 21 22:49:02 volumio volumio[3862]: info: sendMpdCommand status took 11 milliseconds Apr 21 22:49:02 volumio volumio[3862]: info: ------------------------------ 10ms Apr 21 22:49:02 volumio volumio[3862]: info: sendMpdCommand status took 8 milliseconds Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:02 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 21 22:49:02 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 21 22:49:02 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:02 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:02 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:02 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:02 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46427,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:02 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:02 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:02 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:02 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:02 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46427,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:02 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:02 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:02 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:02 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:02 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46427,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:02 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:02 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:02 volumio volumio[3862]: info: ------------------------------ 324ms Apr 21 22:49:02 volumio volumio[3862]: info: ------------------------------ 322ms Apr 21 22:49:02 volumio volumio[3862]: info: ------------------------------ 325ms Apr 21 22:49:02 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:02 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:02 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:03 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:03 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:03 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 31ms Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand status took 26 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 24ms Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand status took 19 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 17ms Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand status took 11 milliseconds Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:03 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:03 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47160,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:03 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:03 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:03 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:03 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47160,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:03 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:03 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:03 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:03 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47160,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:03 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:03 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 286ms Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 280ms Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 272ms Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:03 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:03 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:03 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:03 volumio volumio[3862]: info: Apr 21 22:49:03 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 24ms Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand status took 21 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 20ms Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand status took 16 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 14ms Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand status took 11 milliseconds Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 21 22:49:03 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:03 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:03 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:03 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47629,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:03 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:03 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:03 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:03 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47629,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:03 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:03 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:03 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:03 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47629,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:03 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:03 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:03 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 276ms Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 271ms Apr 21 22:49:03 volumio volumio[3862]: info: ------------------------------ 267ms Apr 21 22:49:09 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Apr 21 22:49:09 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Apr 21 22:49:09 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:10 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:10 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:10 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::volumioStop Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::stop Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::stPlaybackTimer Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::updateTrackBlock Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrackBlock Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::serviceStop Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::serviceStop Apr 21 22:49:11 volumio volumio[3862]: info: [1745246951180] ControllerWebradio::stop Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand stop Apr 21 22:49:11 volumio volumio[3862]: info: Apr 21 22:49:11 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:11 volumio volumio[3862]: info: sendMpdCommand stop took 77 milliseconds Apr 21 22:49:11 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:11 volumio volumio[3862]: info: sendMpdCommand status took 4 milliseconds Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:11 volumio volumio[3862]: info: Apr 21 22:49:11 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:11 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:11 volumio volumio[3862]: info: Apr 21 22:49:11 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:11 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:11 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 87 milliseconds Apr 21 22:49:11 volumio volumio[3862]: info: sendMpdCommand status took 84 milliseconds Apr 21 22:49:11 volumio volumio[3862]: info: sendMpdCommand status took 93 milliseconds Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:11 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 21 22:49:11 volumio volumio[3862]: info: ------------------------------ 185ms Apr 21 22:49:11 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 72 milliseconds Apr 21 22:49:11 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 72 milliseconds Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:11 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:11 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 21 22:49:11 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:11 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:11 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:11 volumio volumio[3862]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 21 22:49:11 volumio volumio[3862]: info: ------------------------------ 289ms Apr 21 22:49:11 volumio volumio[3862]: info: ------------------------------ 286ms Apr 21 22:49:11 volumio volumio[3862]: info: touch_display: Setting screensaver timeout to 10 seconds. Apr 21 22:49:12 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Apr 21 22:49:12 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Apr 21 22:49:12 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:12 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:12 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:12 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:49:12 volumio volumio[3862]: info: peppy_screensaver: Start PeppyMeter Apr 21 22:49:13 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Apr 21 22:49:13 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Apr 21 22:49:13 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:13 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 22:49:13 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:49:17 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Apr 21 22:49:17 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Apr 21 22:49:17 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:49:19 volumio ntpd[697]: 193.182.111.143 local addr 192.168.0.129 -> Apr 21 22:49:21 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Apr 21 22:49:21 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Apr 21 22:49:21 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:49:24 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Apr 21 22:49:24 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Apr 21 22:49:24 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:49:27 volumio volumio[3862]: info: CoreCommandRouter::volumioPlay Apr 21 22:49:27 volumio volumio[3862]: info: CoreStateMachine::play index undefined Apr 21 22:49:27 volumio volumio[3862]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 21 22:49:27 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:27 volumio volumio[3862]: info: CoreStateMachine::startPlaybackTimer Apr 21 22:49:27 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:27 volumio volumio[3862]: info: [1745246967104] ControllerWebradio::clearAddPlayTrack Apr 21 22:49:27 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand stop Apr 21 22:49:27 volumio volumio[3862]: info: sendMpdCommand stop took 2 milliseconds Apr 21 22:49:27 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand clear Apr 21 22:49:27 volumio volumio[3862]: info: Apr 21 22:49:27 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:27 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:27 volumio volumio[3862]: info: sendMpdCommand clear took 4 milliseconds Apr 21 22:49:27 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Apr 21 22:49:27 volumio volumio[3862]: info: Apr 21 22:49:27 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:27 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:27 volumio volumio[3862]: info: Apr 21 22:49:27 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:27 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:27 volumio volumio[3862]: error: updateQueue error: null Apr 21 22:49:27 volumio volumio[3862]: info: ------------------------------ 13ms Apr 21 22:49:28 volumio volumio[3862]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 1180 milliseconds Apr 21 22:49:28 volumio volumio[3862]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 21 22:49:28 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand play Apr 21 22:49:28 volumio volumio[3862]: info: Apr 21 22:49:28 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:28 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:28 volumio volumio[3862]: info: ------------------------------ 1184ms Apr 21 22:49:28 volumio volumio[3862]: info: ------------------------------ 1182ms Apr 21 22:49:28 volumio volumio[3862]: info: sendMpdCommand play took 6 milliseconds Apr 21 22:49:28 volumio volumio[3862]: info: Apr 21 22:49:28 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:28 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:28 volumio volumio[3862]: info: Apr 21 22:49:28 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:28 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:28 volumio volumio[3862]: info: ------------------------------ 12ms Apr 21 22:49:28 volumio volumio[3862]: info: ------------------------------ 7ms Apr 21 22:49:28 volumio volumio[3862]: info: ------------------------------ 5ms Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:29 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand status took 20 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand status took 21 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand status took 18 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand status took 6 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: 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 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:29 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus stop Apr 21 22:49:29 volumio volumio[3862]: info: ------------------------------ 40ms Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 23 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 23 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 23 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand status took 9 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand status took 5 milliseconds Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: 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 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:29 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:29 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: 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 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:29 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:29 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: 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 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:29 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:29 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: ------------------------------ 312ms Apr 21 22:49:29 volumio volumio[3862]: info: ------------------------------ 311ms Apr 21 22:49:29 volumio volumio[3862]: info: ------------------------------ 301ms Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:29 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:29 volumio volumio[3862]: info: Apr 21 22:49:29 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 271 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 271 milliseconds Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:29 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: 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 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:29 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:29 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: 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 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:29 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:29 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:29 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 481ms Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 473ms Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:30 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:30 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:30 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 315ms Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand status took 311 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 27ms Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand status took 24 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 22ms Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand status took 19 milliseconds Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:30 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:30 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:30 volumio volumio[3862]: info: Apr 21 22:49:30 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 52ms Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand status took 45 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 38 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 37 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 38 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 36ms Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand status took 38 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 36ms Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand status took 33 milliseconds Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:30 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:30 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":816,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:30 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:30 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:30 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:30 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:30 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:30 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:30 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:30 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:30 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:30 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 644ms Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 357ms Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 353ms Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 303 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 301 milliseconds Apr 21 22:49:30 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 300 milliseconds Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:30 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:30 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:30 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1193,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:30 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:30 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:30 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:30 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1193,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:30 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:30 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:30 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:30 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1193,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:30 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:30 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:30 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 666ms Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 648ms Apr 21 22:49:30 volumio volumio[3862]: info: ------------------------------ 644ms Apr 21 22:49:30 volumio volumio[3862]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%205086%2F500000)%20ANTENNE%20BAYERN/85860933-2196-4b47-8822-8c6f9f3e7602.jpg' Apr 21 22:49:31 volumio volumio[3862]: info: Apr 21 22:49:31 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:31 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:31 volumio volumio[3862]: info: Apr 21 22:49:31 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:31 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:31 volumio volumio[3862]: info: Apr 21 22:49:31 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:31 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:31 volumio volumio[3862]: info: Apr 21 22:49:31 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:31 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:31 volumio volumio[3862]: info: ------------------------------ 15ms Apr 21 22:49:31 volumio volumio[3862]: info: ------------------------------ 12ms Apr 21 22:49:31 volumio volumio[3862]: info: ------------------------------ 9ms Apr 21 22:49:31 volumio volumio[3862]: info: Apr 21 22:49:31 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:31 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:31 volumio volumio[3862]: info: Apr 21 22:49:31 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:31 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:31 volumio volumio[3862]: info: sendMpdCommand status took 13 milliseconds Apr 21 22:49:31 volumio volumio[3862]: info: sendMpdCommand status took 8 milliseconds Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:31 volumio volumio[3862]: info: sendMpdCommand status took 11 milliseconds Apr 21 22:49:31 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:31 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:31 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:31 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:31 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2026,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:31 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:31 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:31 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:31 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:31 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2026,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:31 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:31 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:31 volumio volumio[3862]: info: ------------------------------ 186ms Apr 21 22:49:31 volumio volumio[3862]: info: ------------------------------ 182ms Apr 21 22:49:31 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 163 milliseconds Apr 21 22:49:31 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:31 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:31 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:31 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2026,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:31 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:31 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:31 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:31 volumio volumio[3862]: info: ------------------------------ 267ms Apr 21 22:49:33 volumio volumio[3862]: info: Apr 21 22:49:33 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:33 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:33 volumio volumio[3862]: info: Apr 21 22:49:33 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:33 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:33 volumio volumio[3862]: info: Apr 21 22:49:33 volumio volumio[3862]: ---------------------------- MPD announces system playlist update Apr 21 22:49:33 volumio volumio[3862]: info: Ignoring MPD Status Update Apr 21 22:49:33 volumio volumio[3862]: info: Apr 21 22:49:33 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:33 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:33 volumio volumio[3862]: info: Apr 21 22:49:33 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:33 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:33 volumio volumio[3862]: info: Apr 21 22:49:33 volumio volumio[3862]: ---------------------------- MPD announces state update: player Apr 21 22:49:33 volumio volumio[3862]: info: ControllerMpd::getState Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand status Apr 21 22:49:33 volumio volumio[3862]: info: ------------------------------ 18ms Apr 21 22:49:33 volumio volumio[3862]: info: ------------------------------ 16ms Apr 21 22:49:33 volumio volumio[3862]: info: ------------------------------ 13ms Apr 21 22:49:33 volumio volumio[3862]: info: sendMpdCommand status took 9 milliseconds Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:33 volumio volumio[3862]: info: sendMpdCommand status took 11 milliseconds Apr 21 22:49:33 volumio volumio[3862]: info: sendMpdCommand status took 7 milliseconds Apr 21 22:49:33 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::parseState Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:33 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:33 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:33 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4158,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:33 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:33 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:33 volumio volumio[3862]: info: ------------------------------ 115ms Apr 21 22:49:33 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 102 milliseconds Apr 21 22:49:33 volumio volumio[3862]: info: sendMpdCommand playlistinfo took 102 milliseconds Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:33 volumio volumio[3862]: verbose: ControllerMpd::parseTrackInfo Apr 21 22:49:33 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:33 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:33 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4158,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:33 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:33 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:33 volumio volumio[3862]: info: ControllerMpd::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::servicePushState Apr 21 22:49:33 volumio volumio[3862]: info: CorePlayQueue::getTrack 0 Apr 21 22:49:33 volumio volumio[3862]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4158,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miley Cyrus - Midnight Sky","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Apr 21 22:49:33 volumio volumio[3862]: verbose: CURRENT POSITION 0 Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::syncState stateService play Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::syncState currentStatus play Apr 21 22:49:33 volumio volumio[3862]: info: Received an update from plugin. extracting info from payload Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:33 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:33 volumio volumio[3862]: info: ------------------------------ 266ms Apr 21 22:49:33 volumio volumio[3862]: info: ------------------------------ 266ms Apr 21 22:49:43 volumio volumio[3862]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Apr 21 22:49:43 volumio volumio[3862]: info: CoreCommandRouter::volumioGetState Apr 21 22:49:47 volumio volumio[3862]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Apr 21 22:49:47 volumio volumio[3862]: info: CoreCommandRouter::volumioGetState Apr 21 22:49:54 volumio volumio[3862]: info: VolumeController::SetAlsaVolume45 Apr 21 22:49:54 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:54 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:54 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:49:55 volumio volumio[3862]: info: VolumeController::SetAlsaVolume76 Apr 21 22:49:55 volumio volumio[3862]: info: CoreStateMachine::pushState Apr 21 22:49:55 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 22:49:55 volumio volumio[3862]: info: CoreCommandRouter::volumioPushState Apr 21 22:50:12 volumio volumio[3862]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Apr 21 22:50:12 volumio volumio[3862]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Apr 21 22:50:12 volumio volumio[3862]: error: Failed callmethod call: TypeError: Cannot read property '0' of undefined Apr 21 22:50:14 volumio volumio[3862]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 22:50:14 volumio volumio[3862]: Error: connect ETIMEDOUT 104.244.46.71:80 Apr 21 22:50:14 volumio volumio[3862]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 21 22:50:14 volumio volumio[3862]: errno: -110, Apr 21 22:50:14 volumio volumio[3862]: code: 'ETIMEDOUT', Apr 21 22:50:14 volumio volumio[3862]: syscall: 'connect', Apr 21 22:50:14 volumio volumio[3862]: address: '104.244.46.71', Apr 21 22:50:14 volumio volumio[3862]: port: 80 Apr 21 22:50:14 volumio volumio[3862]: } Apr 21 22:50:14 volumio volumio[3862]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 22:50:16 volumio sudo[4653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-21 22:49 Apr 21 22:50:16 volumio sudo[4653]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"