-- 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"