-- Logs begin at Thu 2026-01-08 04:55:33 UTC, end at Tue 2026-06-02 09:39:53 UTC. -- Jun 02 09:38:01 opera volumio[2878]: info: Command Router : Notfying DB Updatetrue Jun 02 09:38:01 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:01 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:01 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:01 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:38:01 opera volumio[2878]: info: Jun 02 09:38:01 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:38:01 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:01 opera volumio[2878]: info: Jun 02 09:38:01 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:01 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:01 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:01 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:01 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:01 opera volumio[2878]: info: sendMpdCommand playlistinfo took 19 milliseconds Jun 02 09:38:01 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:01 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:01 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:01 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:01 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52546,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"588 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:01 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:01 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:01 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:01 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:01 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:01 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:01 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:01 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:01 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:01 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:01 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:01 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:01 opera volumio[2878]: info: ------------------------------ 1828ms Jun 02 09:38:01 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:01 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:01 opera volumio[2878]: info: sendMpdCommand status took 92 milliseconds Jun 02 09:38:01 opera volumio[2878]: info: sendMpdCommand status took 81 milliseconds Jun 02 09:38:01 opera volumio[2878]: info: sendMpdCommand status took 83 milliseconds Jun 02 09:38:01 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:02 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:02 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:02 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:02 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:02 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:02 opera volumio[2878]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 02 09:38:02 opera volumio[2878]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 02 09:38:02 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:02 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:02 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:02 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:02 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54427,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"559 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:02 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:02 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:02 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:02 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:02 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:02 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:02 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54427,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"559 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:02 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:02 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:02 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:02 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:02 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:02 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:02 opera volumio[2878]: info: ------------------------------ 713ms Jun 02 09:38:02 opera volumio[2878]: info: ------------------------------ 714ms Jun 02 09:38:02 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:02 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:02 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:02 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:12 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:12 opera volumio[2878]: info: Jun 02 09:38:12 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:12 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:12 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:12 opera volumio[2878]: info: sendMpdCommand status took 2 milliseconds Jun 02 09:38:12 opera volumio[2878]: info: sendMpdCommand status took 1 milliseconds Jun 02 09:38:12 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: info: Command Router : Notfying DB Updatetrue Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:14 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:38:14 opera volumio[2878]: info: Jun 02 09:38:14 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:14 opera volumio[2878]: info: Jun 02 09:38:14 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:14 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:38:14 opera volumio[2878]: info: Jun 02 09:38:14 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:14 opera volumio[2878]: info: Jun 02 09:38:14 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:14 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:14 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:14 opera volumio[2878]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 02 09:38:14 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:14 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:14 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:14 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:14 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65549,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"520 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:14 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:14 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:14 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:14 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:14 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:14 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:14 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:14 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:14 opera volumio[2878]: info: ------------------------------ 1939ms Jun 02 09:38:14 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:14 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:14 opera volumio[2878]: info: sendMpdCommand status took 71 milliseconds Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:14 opera volumio[2878]: info: sendMpdCommand status took 182 milliseconds Jun 02 09:38:14 opera volumio[2878]: info: sendMpdCommand status took 182 milliseconds Jun 02 09:38:14 opera volumio[2878]: info: sendMpdCommand status took 182 milliseconds Jun 02 09:38:14 opera volumio[2878]: info: sendMpdCommand status took 182 milliseconds Jun 02 09:38:14 opera volumio[2878]: info: sendMpdCommand status took 182 milliseconds Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:38:14 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:14 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:15 opera volumio[2878]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 02 09:38:15 opera volumio[2878]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 02 09:38:15 opera volumio[2878]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 02 09:38:15 opera volumio[2878]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 02 09:38:15 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:15 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:15 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:15 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:15 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67430,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"623 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:15 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:15 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67430,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"623 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:15 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:15 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67430,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"623 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:15 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:15 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":67430,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"623 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:15 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:15 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:15 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:15 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:15 opera volumio[2878]: info: ------------------------------ 266ms Jun 02 09:38:15 opera volumio[2878]: info: ------------------------------ 267ms Jun 02 09:38:15 opera volumio[2878]: info: ------------------------------ 268ms Jun 02 09:38:15 opera volumio[2878]: info: ------------------------------ 267ms Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:15 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:36 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:36 opera volumio[2878]: info: Jun 02 09:38:36 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:36 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:36 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:36 opera volumio[2878]: info: sendMpdCommand status took 1 milliseconds Jun 02 09:38:36 opera volumio[2878]: info: sendMpdCommand status took 1 milliseconds Jun 02 09:38:36 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:40 opera volumio[2878]: info: Command Router : Notfying DB Updatetrue Jun 02 09:38:40 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:40 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:40 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:40 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:38:40 opera volumio[2878]: info: Jun 02 09:38:40 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:38:40 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:40 opera volumio[2878]: info: Jun 02 09:38:40 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:40 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:40 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:40 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:40 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:40 opera volumio[2878]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 02 09:38:40 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:40 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:40 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:40 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:40 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89303,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"615 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:40 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:40 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:40 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:40 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:40 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:40 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:40 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:40 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:40 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:40 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:40 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:40 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:40 opera volumio[2878]: info: ------------------------------ 4258ms Jun 02 09:38:40 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:40 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:40 opera volumio[2878]: info: sendMpdCommand status took 73 milliseconds Jun 02 09:38:40 opera volumio[2878]: info: sendMpdCommand status took 64 milliseconds Jun 02 09:38:40 opera volumio[2878]: info: sendMpdCommand status took 64 milliseconds Jun 02 09:38:40 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:41 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:41 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:41 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:41 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:41 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:41 opera volumio[2878]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 02 09:38:41 opera volumio[2878]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 02 09:38:41 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:41 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:41 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:41 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:41 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93553,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"514 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:41 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:41 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:41 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:41 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:41 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:41 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:41 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93553,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"506 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:41 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:41 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:41 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:41 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:41 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:41 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:41 opera volumio[2878]: info: ------------------------------ 269ms Jun 02 09:38:41 opera volumio[2878]: info: ------------------------------ 269ms Jun 02 09:38:41 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:41 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:41 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:41 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:43 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:38:43 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:38:44 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:38:44 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:38:45 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: cd_controller , handleBrowseUri Jun 02 09:38:52 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:52 opera volumio[2878]: info: Jun 02 09:38:52 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:52 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:52 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:52 opera volumio[2878]: info: sendMpdCommand status took 1 milliseconds Jun 02 09:38:52 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: info: Command Router : Notfying DB Updatetrue Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:54 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:38:54 opera volumio[2878]: info: Jun 02 09:38:54 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:54 opera volumio[2878]: info: Jun 02 09:38:54 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand status took 1618 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:54 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:38:54 opera volumio[2878]: info: Jun 02 09:38:54 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:54 opera volumio[2878]: info: Jun 02 09:38:54 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand status took 35 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand status took 35 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand status took 35 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand playlistinfo took 34 milliseconds Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":105302,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"697 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:54 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:54 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: ------------------------------ 1698ms Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand status took 90 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand status took 90 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand status took 90 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand playlistinfo took 38 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand playlistinfo took 39 milliseconds Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107067,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"570 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:54 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:54 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107067,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"570 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:54 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:54 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: ------------------------------ 168ms Jun 02 09:38:54 opera volumio[2878]: info: ------------------------------ 168ms Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand playlistinfo took 53 milliseconds Jun 02 09:38:54 opera volumio[2878]: info: sendMpdCommand playlistinfo took 53 milliseconds Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:54 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107067,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"570 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:54 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:54 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107067,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"570 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:38:54 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:38:54 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:38:54 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:38:54 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:38:54 opera volumio[2878]: info: ------------------------------ 198ms Jun 02 09:38:54 opera volumio[2878]: info: ------------------------------ 198ms Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:38:54 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:08 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:08 opera volumio[2878]: info: Jun 02 09:39:08 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:39:08 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:08 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:08 opera volumio[2878]: info: sendMpdCommand status took 3 milliseconds Jun 02 09:39:08 opera volumio[2878]: info: sendMpdCommand status took 2 milliseconds Jun 02 09:39:08 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:11 opera volumio[2878]: info: Command Router : Notfying DB Updatetrue Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:11 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:39:11 opera volumio[2878]: info: Jun 02 09:39:11 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:11 opera volumio[2878]: info: Jun 02 09:39:11 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:39:11 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:11 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:11 opera volumio[2878]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:11 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":121184,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"505 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:11 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:11 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:11 opera volumio[2878]: info: ------------------------------ 2780ms Jun 02 09:39:11 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:11 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:11 opera volumio[2878]: info: sendMpdCommand status took 76 milliseconds Jun 02 09:39:11 opera volumio[2878]: info: sendMpdCommand status took 66 milliseconds Jun 02 09:39:11 opera volumio[2878]: info: sendMpdCommand status took 66 milliseconds Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:11 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:11 opera volumio[2878]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 02 09:39:11 opera volumio[2878]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:11 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:11 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":123948,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"555 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:11 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:11 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:11 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":123948,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"555 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:11 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:11 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:11 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:11 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:11 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:11 opera volumio[2878]: info: ------------------------------ 419ms Jun 02 09:39:11 opera volumio[2878]: info: ------------------------------ 420ms Jun 02 09:39:11 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:11 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:11 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:11 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: Jun 02 09:39:22 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 2 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 1 milliseconds Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: info: Command Router : Notfying DB Updatetrue Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:22 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:39:22 opera volumio[2878]: info: Jun 02 09:39:22 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: Jun 02 09:39:22 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":135186,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:22 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:22 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: ------------------------------ 67ms Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:39:22 opera volumio[2878]: info: Jun 02 09:39:22 opera volumio[2878]: ---------------------------- MPD announces state update: database Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: Jun 02 09:39:22 opera volumio[2878]: ---------------------------- MPD announces state update: update Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::getState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 88 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 88 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 87 milliseconds Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 94 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 82 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand status took 82 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand playlistinfo took 27 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand playlistinfo took 26 milliseconds Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: info: Command Router : Notfying DB Updatefalse Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseState Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":135186,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:22 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:22 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":135186,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:22 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:22 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: ------------------------------ 191ms Jun 02 09:39:22 opera volumio[2878]: info: ------------------------------ 191ms Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand playlistinfo took 52 milliseconds Jun 02 09:39:22 opera volumio[2878]: info: sendMpdCommand playlistinfo took 52 milliseconds Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:22 opera volumio[2878]: verbose: ControllerMpd::parseTrackInfo Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":135186,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:22 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:22 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: ControllerMpd::pushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::servicePushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":135186,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"No. 1 in G Major. Sarabande","artist":"Bach J.S.","album":"Cello Suites - Starker J.","uri":"INTERNAL/Bach J.S.-Cello Suites - Starker J./No. 1 in G Major. Sarabande.flac","trackType":"flac"} Jun 02 09:39:22 opera volumio[2878]: verbose: CURRENT POSITION 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState stateService play Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::syncState currentStatus play Jun 02 09:39:22 opera volumio[2878]: info: Received an update from plugin. extracting info from payload Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: CoreStateMachine::pushState Jun 02 09:39:22 opera volumio[2878]: info: CorePlayQueue::getTrack 3 Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::volumioPushState Jun 02 09:39:22 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:39:22 opera volumio[2878]: info: ------------------------------ 190ms Jun 02 09:39:22 opera volumio[2878]: info: ------------------------------ 190ms Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:22 opera volumio[2878]: info: Updating RAAT Signal Path Jun 02 09:39:23 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:39:23 opera volumio[2878]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 09:39:23 opera volumio[2878]: info: CURURI: music-library Jun 02 09:39:44 opera volumio[2878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Claudio%20Arrau/Complete%20Philips%20Recordings/d2e79871-544a-40dd-ad7b-f7d2dee94506.jpg' Jun 02 09:39:44 opera volumio[2878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/GARY%20KARR/ADAGIO%20D%27ALBINONI/df885022-ead2-40ce-b974-b2bdb6afe027.jpg' Jun 02 09:39:45 opera volumio[2878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Glenn%20Gould/Goldberg%20Variations/45c3d608-e4d3-436f-847f-860b89a9459c.png' Jun 02 09:39:52 opera volumio[2878]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 09:39:52 opera volumio[2878]: { Error: connect ETIMEDOUT 104.244.43.182:443 Jun 02 09:39:52 opera volumio[2878]: at Object._errnoException (util.js:1022:11) Jun 02 09:39:52 opera volumio[2878]: at _exceptionWithHostPort (util.js:1044:20) Jun 02 09:39:52 opera volumio[2878]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 02 09:39:52 opera volumio[2878]: code: 'ETIMEDOUT', Jun 02 09:39:52 opera volumio[2878]: errno: 'ETIMEDOUT', Jun 02 09:39:52 opera volumio[2878]: syscall: 'connect', Jun 02 09:39:52 opera volumio[2878]: address: '104.244.43.182', Jun 02 09:39:52 opera volumio[2878]: port: 443 } Jun 02 09:39:52 opera volumio[2878]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 09:39:53 opera sudo[21147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 09:38 Jun 02 09:39:53 opera sudo[21147]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"