-- Logs begin at Tue 2025-05-13 21:56:33 +07, end at Tue 2025-05-13 22:02:19 +07. -- May 13 22:01:11 volumio volumio[1520]: info: May 13 22:01:11 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:11 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:11 volumio volumio[1520]: info: May 13 22:01:11 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:11 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:11 volumio volumio[1520]: info: May 13 22:01:11 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:11 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:11 volumio volumio[1520]: info: May 13 22:01:11 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:11 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:11 volumio volumio[1520]: info: May 13 22:01:11 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:11 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:11 volumio volumio[1520]: info: sendMpdCommand status took 31 milliseconds May 13 22:01:11 volumio volumio[1520]: info: sendMpdCommand status took 29 milliseconds May 13 22:01:11 volumio volumio[1520]: info: sendMpdCommand status took 27 milliseconds May 13 22:01:11 volumio volumio[1520]: info: sendMpdCommand status took 19 milliseconds May 13 22:01:11 volumio volumio[1520]: info: sendMpdCommand status took 13 milliseconds May 13 22:01:11 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 2 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 2 May 13 22:01:11 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:11 volumio volumio[1520]: verbose: CURRENT POSITION 2 May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::play index undefined May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:11 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: No code May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:11 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: No code May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:11 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: No code May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:11 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:11 volumio volumio[1520]: info: No code May 13 22:01:11 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:11 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:11 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::startPlaybackTimer May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::clearAddPlayTracks USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand stop May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 378ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 371ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 370ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 369ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 363ms May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand stop took 65 milliseconds May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand clear May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand clear took 61 milliseconds May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand add "USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav" May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 2243, instance 1, run: true May 13 22:01:12 volumio volumio[1520]: error: updateQueue error: null May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 91ms May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand add "USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav" took 88 milliseconds May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 85ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 83ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 80ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 76ms May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand play May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:12 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 51ms May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand play took 41 milliseconds May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 29ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 25ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 19ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 15ms May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 84 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 40 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 35 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 23 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 18 milliseconds May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: May 13 22:01:12 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:12 volumio volumio[1520]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 13 22:01:12 volumio volumio[1520]: info: FusionDsp - ---- read samplerate from file: 44100 May 13 22:01:12 volumio volumio[1520]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 61 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 50 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 50 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 50 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 50 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 49 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 40 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 36 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 32 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand status took 29 milliseconds May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 264ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 334ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 331ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 327ms May 13 22:01:12 volumio volumio[1520]: info: ------------------------------ 315ms May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 238 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 232 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 231 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 230 milliseconds May 13 22:01:12 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 229 milliseconds May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1830,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1830,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1830,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1830,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Suteki da ne.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01 - Suteki da ne.wav","trackType":"wav"} May 13 22:01:12 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:12 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:12 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:12 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:12 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:13 volumio volumio[1520]: info: ------------------------------ 617ms May 13 22:01:13 volumio volumio[1520]: info: ------------------------------ 592ms May 13 22:01:13 volumio volumio[1520]: info: ------------------------------ 592ms May 13 22:01:13 volumio volumio[1520]: info: ------------------------------ 591ms May 13 22:01:13 volumio volumio[1520]: info: ------------------------------ 589ms May 13 22:01:13 volumio volumio[1520]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 13 22:01:13 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 13 22:01:13 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 13 22:01:13 volumio volumio[1520]: info: CoreCommandRouter::getUIConfigOnPlugin May 13 22:01:18 volumio volumio[1520]: info: camilladsp spawned new process with pid 2252, instance 1, run: true May 13 22:01:26 volumio volumio[1520]: info: camilladsp spawned new process with pid 2273, instance 1, run: true May 13 22:01:31 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 13 22:01:31 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 13 22:01:35 volumio ntpd[822]: Soliciting pool server 115.165.161.155 May 13 22:01:38 volumio ntpd[822]: Soliciting pool server 103.184.124.254 May 13 22:01:38 volumio volumio[1520]: info: camilladsp spawned new process with pid 2298, instance 1, run: true May 13 22:01:38 volumio volumio[1520]: info: camilladsp spawned new process with pid 2319, instance 1, run: true May 13 22:01:39 volumio ntpd[822]: Soliciting pool server 103.199.19.135 May 13 22:01:40 volumio ntpd[822]: Soliciting pool server 27.71.27.209 May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 3 milliseconds May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 3 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 3 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::play index undefined May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::setConsumeUpdateService undefined May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::startPlaybackTimer May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::clearAddPlayTracks USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand stop May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 67ms May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand stop took 48 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 17 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 15 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 16 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 14 milliseconds May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand clear May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: No code May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: No code May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: No code May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: No code May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 300ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 301ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 301ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 301ms May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand clear took 358 milliseconds May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand add "USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav" May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: error: updateQueue error: null May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 35ms May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand add "USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav" took 32 milliseconds May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 30ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 28ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 25ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 20ms May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand play May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces system playlist update May 13 22:01:41 volumio volumio[1520]: info: Ignoring MPD Status Update May 13 22:01:41 volumio volumio[1520]: info: camilladsp spawned new process with pid 2327, instance 1, run: true May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 104ms May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand play took 97 milliseconds May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 99ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 96ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 94ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 91ms May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 13 22:01:41 volumio volumio[1520]: info: FusionDsp - ---- read samplerate from file: 44100 May 13 22:01:41 volumio volumio[1520]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 41 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 38 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 34 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 30 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 26 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 23 milliseconds May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: May 13 22:01:41 volumio volumio[1520]: ---------------------------- MPD announces state update: player May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::getState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand status May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 31 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 31 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 30 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 30 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 30 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 29 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 25 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 21 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 17 milliseconds May 13 22:01:41 volumio volumio[1520]: info: sendMpdCommand status took 15 milliseconds May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::parseState May 13 22:01:41 volumio volumio[1520]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus stop May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:41 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:41 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:41 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:41 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:41 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:41 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:41 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:41 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 203ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 349ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 340ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 338ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 334ms May 13 22:01:41 volumio volumio[1520]: info: ------------------------------ 332ms May 13 22:01:42 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 268 milliseconds May 13 22:01:42 volumio volumio[1520]: info: sendMpdCommand playlistinfo took 267 milliseconds May 13 22:01:42 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:42 volumio volumio[1520]: verbose: ControllerMpd::parseTrackInfo May 13 22:01:42 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:42 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:42 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:42 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:42 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:42 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:42 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: ControllerMpd::pushState May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::servicePushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":320,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Le Quyen - Mai Mai Ben Em.wav","artist":null,"album":null,"uri":"USB/0E5E0AD90E5E0AD9/hay nghe/hay nghe 1/01. Le Quyen - Mai Mai Ben Em.wav","trackType":"wav"} May 13 22:01:42 volumio volumio[1520]: verbose: CURRENT POSITION 4 May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState stateService play May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::syncState currentStatus play May 13 22:01:42 volumio volumio[1520]: info: Received an update from plugin. extracting info from payload May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: CoreStateMachine::pushState May 13 22:01:42 volumio volumio[1520]: info: CorePlayQueue::getTrack 4 May 13 22:01:42 volumio volumio[1520]: info: CoreCommandRouter::volumioPushState May 13 22:01:42 volumio volumio[1520]: info: ------------------------------ 519ms May 13 22:01:42 volumio volumio[1520]: info: ------------------------------ 556ms May 13 22:01:42 volumio volumio[1520]: info: ------------------------------ 553ms May 13 22:01:42 volumio volumio[1520]: info: ------------------------------ 551ms May 13 22:01:42 volumio volumio[1520]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 13 22:01:56 volumio volumio[1520]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf May 13 22:01:59 volumio volumio[1520]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf May 13 22:01:59 volumio sudo[2370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd_oled_plugin.service May 13 22:01:59 volumio sudo[2370]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 22:02:00 volumio sudo[2370]: pam_unix(sudo:session): session closed for user root May 13 22:02:00 volumio volumio[1520]: info: [MPD_OLED Plugin] Stopped mpd_oled_plugin service May 13 22:02:00 volumio volumio[1520]: info: Check plugin dependencies May 13 22:02:00 volumio volumio[1520]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 13 22:02:00 volumio volumio[1520]: info: Rename folder May 13 22:02:00 volumio volumio[1520]: info: Folder /tmp/downloaded_plugin.zip removed May 13 22:02:00 volumio volumio[1520]: info: Move to category May 13 22:02:02 volumio volumio[1520]: info: Checking if install.sh is present May 13 22:02:02 volumio volumio[1520]: info: Executing install.sh May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2387, instance 1, run: true May 13 22:02:03 volumio sudo[2386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/mpd_oled/install.sh May 13 22:02:03 volumio sudo[2386]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2394, instance 1, run: true May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2403, instance 1, run: true May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2410, instance 1, run: true May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2417, instance 1, run: true May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2424, instance 1, run: true May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2431, instance 1, run: true May 13 22:02:03 volumio sudo[2438]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/bash mpd_oled_volumio_install_latest.sh May 13 22:02:03 volumio sudo[2438]: pam_unix(sudo:session): session opened for user root by (uid=0) May 13 22:02:03 volumio volumio[1520]: info: camilladsp spawned new process with pid 2441, instance 1, run: true May 13 22:02:04 volumio volumio[1520]: info: camilladsp spawned new process with pid 2448, instance 1, run: true May 13 22:02:04 volumio volumio[1520]: info: camilladsp spawned new process with pid 2455, instance 1, run: true May 13 22:02:04 volumio volumio[1520]: info: camilladsp spawned new process with pid 2463, instance 1, run: true May 13 22:02:04 volumio volumio[1520]: info: camilladsp spawned new process with pid 2471, instance 1, run: true May 13 22:02:04 volumio volumio[1520]: info: camilladsp spawned new process with pid 2480, instance 1, run: true May 13 22:02:04 volumio volumio[1520]: info: camilladsp spawned new process with pid 2489, instance 1, run: true May 13 22:02:04 volumio volumio[1520]: info: camilladsp spawned new process with pid 2496, instance 1, run: true May 13 22:02:05 volumio volumio[1520]: info: camilladsp spawned new process with pid 2503, instance 1, run: true May 13 22:02:05 volumio volumio[1520]: info: camilladsp spawned new process with pid 2510, instance 1, run: true May 13 22:02:05 volumio volumio[1520]: info: camilladsp spawned new process with pid 2517, instance 1, run: true May 13 22:02:05 volumio volumio[1520]: info: Get:1 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] May 13 22:02:05 volumio volumio[1520]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease May 13 22:02:05 volumio volumio[1520]: info: Get:3 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] May 13 22:02:05 volumio volumio[1520]: info: camilladsp spawned new process with pid 2530, instance 1, run: true May 13 22:02:05 volumio volumio[1520]: info: camilladsp spawned new process with pid 2541, instance 1, run: true May 13 22:02:05 volumio volumio[1520]: info: camilladsp spawned new process with pid 2553, instance 1, run: true May 13 22:02:05 volumio volumio[1520]: info: camilladsp spawned new process with pid 2563, instance 1, run: true May 13 22:02:06 volumio volumio[1520]: info: camilladsp spawned new process with pid 2578, instance 1, run: true May 13 22:02:06 volumio volumio[1520]: info: camilladsp spawned new process with pid 2594, instance 1, run: true May 13 22:02:06 volumio volumio[1520]: info: camilladsp spawned new process with pid 2625, instance 1, run: true May 13 22:02:06 volumio volumio[1520]: info: camilladsp spawned new process with pid 2635, instance 1, run: true May 13 22:02:06 volumio volumio[1520]: info: camilladsp spawned new process with pid 2651, instance 1, run: true May 13 22:02:06 volumio volumio[1520]: info: camilladsp spawned new process with pid 2662, instance 1, run: true May 13 22:02:06 volumio volumio[1520]: info: camilladsp spawned new process with pid 2674, instance 1, run: true May 13 22:02:07 volumio volumio[1520]: info: camilladsp spawned new process with pid 2693, instance 1, run: true May 13 22:02:07 volumio volumio[1520]: info: camilladsp spawned new process with pid 2733, instance 1, run: true May 13 22:02:07 volumio volumio[1520]: info: camilladsp spawned new process with pid 2750, instance 1, run: true May 13 22:02:07 volumio volumio[1520]: info: camilladsp spawned new process with pid 2761, instance 1, run: true May 13 22:02:07 volumio volumio[1520]: info: camilladsp spawned new process with pid 2773, instance 1, run: true May 13 22:02:07 volumio volumio[1520]: info: camilladsp spawned new process with pid 2784, instance 1, run: true May 13 22:02:07 volumio volumio[1520]: info: camilladsp spawned new process with pid 2808, instance 1, run: true May 13 22:02:08 volumio volumio[1520]: info: camilladsp spawned new process with pid 2841, instance 1, run: true May 13 22:02:08 volumio volumio[1520]: info: camilladsp spawned new process with pid 2851, instance 1, run: true May 13 22:02:08 volumio volumio[1520]: info: camilladsp spawned new process with pid 2858, instance 1, run: true May 13 22:02:08 volumio volumio[1520]: info: Get:4 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] May 13 22:02:08 volumio volumio[1520]: info: camilladsp spawned new process with pid 2865, instance 1, run: true May 13 22:02:08 volumio volumio[1520]: info: camilladsp spawned new process with pid 2872, instance 1, run: true May 13 22:02:08 volumio volumio[1520]: info: camilladsp spawned new process with pid 2879, instance 1, run: true May 13 22:02:08 volumio volumio[1520]: info: camilladsp spawned new process with pid 2894, instance 1, run: true May 13 22:02:09 volumio volumio[1520]: info: camilladsp spawned new process with pid 2908, instance 1, run: true May 13 22:02:09 volumio volumio[1520]: info: camilladsp spawned new process with pid 2916, instance 1, run: true May 13 22:02:09 volumio volumio[1520]: info: camilladsp spawned new process with pid 2923, instance 1, run: true May 13 22:02:09 volumio volumio[1520]: info: camilladsp spawned new process with pid 2930, instance 1, run: true May 13 22:02:09 volumio volumio[1520]: info: camilladsp spawned new process with pid 2937, instance 1, run: true May 13 22:02:09 volumio volumio[1520]: info: Fetched 470 kB in 5s (96.5 kB/s) May 13 22:02:09 volumio volumio[1520]: info: camilladsp spawned new process with pid 2952, instance 1, run: true May 13 22:02:09 volumio volumio[1520]: info: camilladsp spawned new process with pid 2977, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 2998, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 3005, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 3012, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 3019, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 3026, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 3033, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 3040, instance 1, run: true May 13 22:02:10 volumio volumio[1520]: info: camilladsp spawned new process with pid 3047, instance 1, run: true May 13 22:02:11 volumio volumio[1520]: info: camilladsp spawned new process with pid 3054, instance 1, run: true May 13 22:02:11 volumio volumio[1520]: info: camilladsp spawned new process with pid 3061, instance 1, run: true May 13 22:02:11 volumio volumio[1520]: info: camilladsp spawned new process with pid 3068, instance 1, run: true May 13 22:02:11 volumio volumio[1520]: info: camilladsp spawned new process with pid 3075, instance 1, run: true May 13 22:02:11 volumio volumio[1520]: info: camilladsp spawned new process with pid 3082, instance 1, run: true May 13 22:02:11 volumio volumio[1520]: info: camilladsp spawned new process with pid 3089, instance 1, run: true May 13 22:02:11 volumio volumio[1520]: info: camilladsp spawned new process with pid 3096, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3103, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3110, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3117, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3124, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3131, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3138, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3145, instance 1, run: true May 13 22:02:12 volumio volumio[1520]: info: camilladsp spawned new process with pid 3152, instance 1, run: true May 13 22:02:13 volumio volumio[1520]: info: camilladsp spawned new process with pid 3159, instance 1, run: true May 13 22:02:13 volumio volumio[1520]: info: camilladsp spawned new process with pid 3166, instance 1, run: true May 13 22:02:13 volumio volumio[1520]: info: camilladsp spawned new process with pid 3173, instance 1, run: true May 13 22:02:13 volumio volumio[1520]: info: camilladsp spawned new process with pid 3180, instance 1, run: true May 13 22:02:13 volumio volumio[1520]: info: camilladsp spawned new process with pid 3187, instance 1, run: true May 13 22:02:13 volumio volumio[1520]: info: camilladsp spawned new process with pid 3194, instance 1, run: true May 13 22:02:13 volumio volumio[1520]: info: camilladsp spawned new process with pid 3202, instance 1, run: true May 13 22:02:14 volumio volumio[1520]: info: camilladsp spawned new process with pid 3209, instance 1, run: true May 13 22:02:14 volumio volumio[1520]: info: camilladsp spawned new process with pid 3216, instance 1, run: true May 13 22:02:14 volumio volumio[1520]: info: camilladsp spawned new process with pid 3223, instance 1, run: true May 13 22:02:14 volumio volumio[1520]: info: camilladsp spawned new process with pid 3230, instance 1, run: true May 13 22:02:14 volumio volumio[1520]: info: camilladsp spawned new process with pid 3237, instance 1, run: true May 13 22:02:14 volumio volumio[1520]: info: camilladsp spawned new process with pid 3244, instance 1, run: true May 13 22:02:14 volumio volumio[1520]: info: camilladsp spawned new process with pid 3251, instance 1, run: true May 13 22:02:15 volumio volumio[1520]: info: camilladsp spawned new process with pid 3258, instance 1, run: true May 13 22:02:15 volumio volumio[1520]: info: camilladsp spawned new process with pid 3265, instance 1, run: true May 13 22:02:15 volumio volumio[1520]: info: camilladsp spawned new process with pid 3272, instance 1, run: true May 13 22:02:15 volumio volumio[1520]: info: camilladsp spawned new process with pid 3279, instance 1, run: true May 13 22:02:15 volumio volumio[1520]: info: camilladsp spawned new process with pid 3286, instance 1, run: true May 13 22:02:15 volumio volumio[1520]: info: camilladsp spawned new process with pid 3293, instance 1, run: true May 13 22:02:15 volumio volumio[1520]: info: camilladsp spawned new process with pid 3300, instance 1, run: true May 13 22:02:16 volumio volumio[1520]: info: camilladsp spawned new process with pid 3307, instance 1, run: true May 13 22:02:16 volumio volumio[1520]: info: camilladsp spawned new process with pid 3314, instance 1, run: true May 13 22:02:16 volumio volumio[1520]: info: camilladsp spawned new process with pid 3321, instance 1, run: true May 13 22:02:16 volumio volumio[1520]: info: camilladsp spawned new process with pid 3328, instance 1, run: true May 13 22:02:16 volumio volumio[1520]: info: camilladsp spawned new process with pid 3335, instance 1, run: true May 13 22:02:16 volumio volumio[1520]: info: camilladsp spawned new process with pid 3342, instance 1, run: true May 13 22:02:16 volumio volumio[1520]: info: camilladsp spawned new process with pid 3349, instance 1, run: true May 13 22:02:17 volumio volumio[1520]: info: camilladsp spawned new process with pid 3356, instance 1, run: true May 13 22:02:17 volumio volumio[1520]: info: camilladsp spawned new process with pid 3363, instance 1, run: true May 13 22:02:17 volumio volumio[1520]: info: camilladsp spawned new process with pid 3370, instance 1, run: true May 13 22:02:17 volumio volumio[1520]: info: camilladsp spawned new process with pid 3377, instance 1, run: true May 13 22:02:17 volumio volumio[1520]: info: camilladsp spawned new process with pid 3384, instance 1, run: true May 13 22:02:17 volumio volumio[1520]: info: camilladsp spawned new process with pid 3391, instance 1, run: true May 13 22:02:17 volumio volumio[1520]: info: camilladsp spawned new process with pid 3398, instance 1, run: true May 13 22:02:18 volumio volumio[1520]: info: camilladsp spawned new process with pid 3405, instance 1, run: true May 13 22:02:18 volumio volumio[1520]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 22:02:18 volumio volumio[1520]: Error: connect ETIMEDOUT 151.101.78.79:443 May 13 22:02:18 volumio volumio[1520]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 13 22:02:18 volumio volumio[1520]: errno: -110, May 13 22:02:18 volumio volumio[1520]: code: 'ETIMEDOUT', May 13 22:02:18 volumio volumio[1520]: syscall: 'connect', May 13 22:02:18 volumio volumio[1520]: address: '151.101.78.79', May 13 22:02:18 volumio volumio[1520]: port: 443 May 13 22:02:18 volumio volumio[1520]: } May 13 22:02:18 volumio volumio[1520]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 13 22:02:19 volumio sudo[3435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 22:01 May 13 22:02:19 volumio sudo[3435]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"