-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Mon 2024-07-15 18:13:51 CST. -- Jul 15 18:12:01 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:02 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:03 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:04 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:05 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:06 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:07 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:08 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:09 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:10 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:12 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:13 volumio volumio[11505]: info: Jul 15 18:12:13 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:12:13 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:13 volumio volumio[11505]: info: Jul 15 18:12:13 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:12:13 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:13 volumio volumio[11505]: info: sendMpdCommand status took 26 milliseconds Jul 15 18:12:13 volumio volumio[11505]: info: sendMpdCommand status took 13 milliseconds Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:13 volumio volumio[11505]: info: Command Router : Notfying DB Updatefalse Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:12:13 volumio volumio[11505]: info: sendMpdCommand status took 142 milliseconds Jul 15 18:12:13 volumio volumio[11505]: info: sendMpdCommand status took 139 milliseconds Jul 15 18:12:13 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 36 milliseconds Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:13 volumio volumio[11505]: info: Command Router : Notfying DB Updatefalse Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:12:13 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:12:13 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:12:13 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35931,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:12:13 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:12:13 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:13 volumio volumio[11505]: info: ------------------------------ 414ms Jul 15 18:12:13 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 131 milliseconds Jul 15 18:12:13 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:12:13 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:12:13 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:12:13 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35931,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:12:13 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:12:13 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:13 volumio volumio[11505]: info: ------------------------------ 454ms Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:14 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:15 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:16 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:17 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:18 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:19 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:20 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:22 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:23 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:24 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:25 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:26 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:27 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:28 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:29 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:31 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:32 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:33 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:34 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:35 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:36 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:37 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:38 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:40 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:41 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:42 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:43 volumio volumio[11505]: info: Jul 15 18:12:43 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:12:43 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:43 volumio volumio[11505]: info: sendMpdCommand status took 31 milliseconds Jul 15 18:12:43 volumio volumio[11505]: info: sendMpdCommand status took 29 milliseconds Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:43 volumio volumio[11505]: info: Command Router : Notfying DB Updatetrue Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:43 volumio volumio[11505]: info: Jul 15 18:12:43 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:12:43 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:12:43 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 29 milliseconds Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:12:43 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:12:43 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:12:43 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65840,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:12:43 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:12:43 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:43 volumio volumio[11505]: info: ------------------------------ 422ms Jul 15 18:12:43 volumio volumio[11505]: info: sendMpdCommand status took 258 milliseconds Jul 15 18:12:43 volumio volumio[11505]: info: sendMpdCommand status took 253 milliseconds Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:43 volumio volumio[11505]: info: Command Router : Notfying DB Updatefalse Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:12:43 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 36 milliseconds Jul 15 18:12:43 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:12:43 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:12:43 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:12:43 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":66114,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:12:43 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:12:43 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:12:43 volumio volumio[11505]: info: ------------------------------ 444ms Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:12:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:12:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:12:44 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:45 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:46 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:47 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:49 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:50 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:51 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:52 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:53 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:54 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:55 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:56 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:57 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:12:58 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:00 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:01 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:02 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:03 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:04 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:05 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:06 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:07 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:08 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:09 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:11 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:12 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:13 volumio volumio[11505]: info: Jul 15 18:13:13 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:13:13 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:13 volumio volumio[11505]: info: sendMpdCommand status took 6 milliseconds Jul 15 18:13:13 volumio volumio[11505]: info: sendMpdCommand status took 4 milliseconds Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:13 volumio volumio[11505]: info: Command Router : Notfying DB Updatetrue Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:13 volumio volumio[11505]: info: Jul 15 18:13:13 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:13:13 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:13 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 62 milliseconds Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:13:13 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:13:13 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:13:13 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":95839,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:13:13 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:13:13 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:13 volumio volumio[11505]: info: ------------------------------ 259ms Jul 15 18:13:13 volumio volumio[11505]: info: sendMpdCommand status took 158 milliseconds Jul 15 18:13:13 volumio volumio[11505]: info: sendMpdCommand status took 140 milliseconds Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:13 volumio volumio[11505]: info: Command Router : Notfying DB Updatefalse Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:13:13 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 15 18:13:13 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:13:13 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:13:13 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:13:13 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":96022,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:13:13 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:13:13 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:13 volumio volumio[11505]: info: ------------------------------ 336ms Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:13 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:13 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:13 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:14 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:15 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:16 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:17 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:18 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:19 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:21 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:22 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:23 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:24 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:25 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:26 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:27 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:28 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:29 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:30 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:31 volumio nmbd[2260]: [2024/07/15 18:13:31.560810, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 15 18:13:31 volumio nmbd[2260]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.23.117 for name WORKGROUP<1d>. Jul 15 18:13:31 volumio nmbd[2260]: This response was from IP 192.168.23.81, reporting an IP address of 192.168.23.81. Jul 15 18:13:31 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:33 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:34 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:35 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:36 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:37 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:38 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:39 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:40 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:41 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:43 volumio volumio[11505]: info: Jul 15 18:13:43 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:13:43 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:43 volumio volumio[11505]: info: sendMpdCommand status took 15 milliseconds Jul 15 18:13:43 volumio volumio[11505]: info: sendMpdCommand status took 11 milliseconds Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:43 volumio volumio[11505]: info: Command Router : Notfying DB Updatetrue Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:43 volumio volumio[11505]: info: Jul 15 18:13:43 volumio volumio[11505]: ---------------------------- MPD announces state update: update Jul 15 18:13:43 volumio volumio[11505]: info: ControllerMpd::getState Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand status Jul 15 18:13:43 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 35 milliseconds Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:13:43 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:13:43 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:13:43 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125839,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:13:43 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:13:43 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:43 volumio volumio[11505]: info: ------------------------------ 253ms Jul 15 18:13:43 volumio volumio[11505]: info: sendMpdCommand status took 145 milliseconds Jul 15 18:13:43 volumio volumio[11505]: info: sendMpdCommand status took 138 milliseconds Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:43 volumio volumio[11505]: info: Command Router : Notfying DB Updatefalse Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::Close All Modals sent Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::parseState Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 15 18:13:43 volumio volumio[11505]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 15 18:13:43 volumio volumio[11505]: verbose: ControllerMpd::parseTrackInfo Jul 15 18:13:43 volumio volumio[11505]: info: ControllerMpd::pushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::servicePushState Jul 15 18:13:43 volumio volumio[11505]: verbose: In UPNP mode Jul 15 18:13:43 volumio volumio[11505]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125931,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LEGO Ninjago: The Crystalized Whip","artist":"Ninjago Music","album":"LEGO Ninjago: The Crystalized Whip","uri":"http://fsandroid.hw.kugou.com/202407151811/a62ac2b68fc56e7f13f77de4501da578/v3/3a14621cb9a8690972968c688de65c86/yp/full/a1005_u0_d3mikq83s18ly1o9z7t2lq6xd_p2_mx511815132_s3407795117.mp3","trackType":"mp3"} Jul 15 18:13:43 volumio volumio[11505]: verbose: CURRENT POSITION 0 Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::syncState stateService play Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::syncState currentStatus play Jul 15 18:13:43 volumio volumio[11505]: info: Received an update from plugin. extracting info from payload Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::pushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioPushState Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 15 18:13:43 volumio volumio[11505]: info: ------------------------------ 336ms Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:43 volumio volumio[11505]: info: CoreCommandRouter::volumioGetQueue Jul 15 18:13:43 volumio volumio[11505]: info: CoreStateMachine::getQueue Jul 15 18:13:43 volumio volumio[11505]: info: CorePlayQueue::getQueue Jul 15 18:13:44 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:45 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:46 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:47 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:48 volumio volumio[11505]: info: CoreCommandRouter::volumioGetState Jul 15 18:13:49 volumio volumio[11505]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 15 18:13:49 volumio volumio[11505]: { Error: connect ETIMEDOUT 104.244.46.21:443 Jul 15 18:13:49 volumio volumio[11505]: at Object._errnoException (util.js:1022:11) Jul 15 18:13:49 volumio volumio[11505]: at _exceptionWithHostPort (util.js:1044:20) Jul 15 18:13:49 volumio volumio[11505]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 15 18:13:49 volumio volumio[11505]: code: 'ETIMEDOUT', Jul 15 18:13:49 volumio volumio[11505]: errno: 'ETIMEDOUT', Jul 15 18:13:49 volumio volumio[11505]: syscall: 'connect', Jul 15 18:13:49 volumio volumio[11505]: address: '104.244.46.21', Jul 15 18:13:49 volumio volumio[11505]: port: 443 } Jul 15 18:13:49 volumio volumio[11505]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 15 18:13:51 volumio sudo[15792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-15 18:12 Jul 15 18:13:51 volumio sudo[15792]: pam_unix(sudo:session): session opened for user root by (uid=0) NAME="Ubuntu" VERSION="20.04.5 LTS (Focal Fossa)" ID=ubuntu ID_LIKE=debian PRETTY_NAME="Ubuntu 20.04.5 LTS" VERSION_ID="20.04" HOME_URL="https://www.ubuntu.com/" SUPPORT_URL="https://help.ubuntu.com/" BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/" PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy" VERSION_CODENAME=focal UBUNTU_CODENAME=focal VOLUMIO_BUILD_VERSION="" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7"