-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2025-05-19 01:05:17 CST. -- May 19 01:04:04 volumioa volumio[4767]: info: Clearing queue after UPNP request May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::ClearQueue May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::stop May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::stPlaybackTimer May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::updateTrackBlock May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrackBlock May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::serviceStop May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: ControllerMpd::stop May 19 01:04:05 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand stop May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::clearPlayQueue May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::saveQueue May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushQueue May 19 01:04:05 volumioa mpd[4889]: player: played "http://m701.music.126.net/20250519012856/9ad501175397ecd54e5b4b0deb2299b2/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=UyG0af0pj4P7biUeGb3fZf0PWvoUkNmpY6gfRxgaLZEwG4+VxLr4FufcsfpftuPVzPnd2lAzY2YBkbiwMNJfcSbz5GdNizC6LbhQOrSOycw=" May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:05 volumioa volumio[4767]: info: sendMpdCommand stop took 43 milliseconds May 19 01:04:05 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:05 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:05 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:05 volumioa volumio[4767]: info: sendMpdCommand status took 4 milliseconds May 19 01:04:05 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:05 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 19 01:04:05 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: No code May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 56ms May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:05 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:05 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:05 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:05 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:05 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:05 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 15ms May 19 01:04:05 volumioa volumio[4767]: info: sendMpdCommand status took 10 milliseconds May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:05 volumioa volumio[4767]: info: sendMpdCommand status took 7 milliseconds May 19 01:04:05 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:05 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:05 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 19 01:04:05 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: No code May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 19 01:04:05 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: No code May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 96ms May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 93ms May 19 01:04:05 volumioa volumio[4767]: info: Starting UPNP Playback May 19 01:04:05 volumioa volumio[4767]: info: Preparing playback through UPNP May 19 01:04:05 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetState May 19 01:04:05 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:05 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService mpd May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 12ms May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: May 19 01:04:05 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:05 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:05 volumioa volumio[4767]: info: ------------------------------ 14ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 11ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 10ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 13ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 10ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 15ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 13ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: May 19 01:04:06 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:06 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 13ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 10ms May 19 01:04:06 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:07 volumioa volumio[4767]: info: May 19 01:04:07 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:07 volumioa volumio[4767]: info: May 19 01:04:07 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:07 volumioa volumio[4767]: info: May 19 01:04:07 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:07 volumioa mpd[4889]: output: Failed to open mixer for 'default detected output': no such mixer control: PCM May 19 01:04:07 volumioa volumio[4767]: info: May 19 01:04:07 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand status took 29 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand status took 28 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand status took 27 milliseconds May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:07 volumioa volumio[4767]: info: May 19 01:04:07 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:07 volumioa volumio[4767]: info: May 19 01:04:07 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand status took 13 milliseconds May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 22 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 23 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 25 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand status took 24 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand status took 20 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 39 milliseconds May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:07 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:07 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:07 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:07 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:07 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:07 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:07 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:07 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:07 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:07 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:07 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:07 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:07 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:07 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:07 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: ------------------------------ 161ms May 19 01:04:07 volumioa volumio[4767]: info: ------------------------------ 259ms May 19 01:04:07 volumioa volumio[4767]: info: ------------------------------ 234ms May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 179 milliseconds May 19 01:04:07 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 178 milliseconds May 19 01:04:07 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:07 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:07 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:07 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:07 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:07 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:07 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:07 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:07 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:07 volumioa volumio[4767]: info: ------------------------------ 293ms May 19 01:04:07 volumioa volumio[4767]: info: ------------------------------ 292ms May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:07 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:07 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:10 volumioa thd[752]: Executing trigger action: /usr/local/bin/volumio volume plus May 19 01:04:10 volumioa thd[752]: % Total % Received % Xferd Average Speed Time Time Time Current May 19 01:04:10 volumioa thd[752]: Dload Upload Total Spent Left Speed May 19 01:04:10 volumioa volumio[4767]: info: May 19 01:04:10 volumioa volumio[4767]: ---------------------------- Client requests Volume + May 19 01:04:10 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume+ May 19 01:04:10 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:10 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:10 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:10 volumioa thd[752]: [158B blob data] May 19 01:04:10 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:10 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:10 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:12 volumioa mpd[4889]: player: played "http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=" May 19 01:04:12 volumioa volumio[4767]: info: May 19 01:04:12 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:12 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:12 volumioa volumio[4767]: info: May 19 01:04:12 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:12 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:12 volumioa volumio[4767]: info: May 19 01:04:12 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:12 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:12 volumioa volumio[4767]: info: sendMpdCommand status took 5 milliseconds May 19 01:04:12 volumioa volumio[4767]: info: sendMpdCommand status took 4 milliseconds May 19 01:04:12 volumioa volumio[4767]: info: sendMpdCommand status took 2 milliseconds May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:12 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 3 milliseconds May 19 01:04:12 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 3 milliseconds May 19 01:04:12 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 3 milliseconds May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:12 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:12 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:12 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:12 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::stPlaybackTimer May 19 01:04:12 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:12 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:12 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa volumio[4767]: info: No code May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:12 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"珠玉","artist":"单依纯","album":"珠玉","uri":"http://m801.music.126.net/20250519012904/7953e3b40dbacdcd74f489fb6ce77434/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59968091869/dafe/beb5/a377/69397afe39986f13ec0712f4c1fe81ab.mp3?vuutv=4e8IOiYrEcz6qdvqDvZ+NWShFlKD/wDFAc8088+qdaykjfaVjMb4n8s2eNJYsYA1M5TLyvAdnM/wL17gkz8oQ4qjH3zQgIdqaKmOuvrlJ6Q=","trackType":""} May 19 01:04:12 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa volumio[4767]: info: No code May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa thd[752]: {"time":1747587850719,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus May 19 01:04:12 volumioa volumio[4767]: info: ------------------------------ 161ms May 19 01:04:12 volumioa volumio[4767]: info: ------------------------------ 160ms May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:12 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:12 volumioa thd[752]: % Total % Received % Xferd Average Speed Time Time Time Current May 19 01:04:12 volumioa thd[752]: Dload Upload Total Spent Left Speed May 19 01:04:12 volumioa volumio[4767]: info: May 19 01:04:12 volumioa volumio[4767]: ---------------------------- Client requests Volume + May 19 01:04:12 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume+ May 19 01:04:12 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:12 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:12 volumioa thd[752]: [158B blob data] May 19 01:04:13 volumioa thd[752]: {"time":1747587852902,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus May 19 01:04:13 volumioa thd[752]: % Total % Received % Xferd Average Speed Time Time Time Current May 19 01:04:13 volumioa thd[752]: Dload Upload Total Spent Left Speed May 19 01:04:13 volumioa volumio[4767]: info: May 19 01:04:13 volumioa volumio[4767]: ---------------------------- Client requests Volume + May 19 01:04:13 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume+ May 19 01:04:13 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:13 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:13 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:13 volumioa thd[752]: [158B blob data] May 19 01:04:14 volumioa thd[752]: {"time":1747587853236,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus May 19 01:04:14 volumioa thd[752]: % Total % Received % Xferd Average Speed Time Time Time Current May 19 01:04:14 volumioa thd[752]: Dload Upload Total Spent Left Speed May 19 01:04:14 volumioa volumio[4767]: info: May 19 01:04:14 volumioa volumio[4767]: ---------------------------- Client requests Volume + May 19 01:04:14 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume+ May 19 01:04:14 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:14 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:14 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:14 volumioa thd[752]: [158B blob data] May 19 01:04:16 volumioa thd[752]: {"time":1747587854950,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus May 19 01:04:16 volumioa thd[752]: % Total % Received % Xferd Average Speed Time Time Time Current May 19 01:04:16 volumioa thd[752]: Dload Upload Total Spent Left Speed May 19 01:04:16 volumioa volumio[4767]: info: May 19 01:04:16 volumioa volumio[4767]: ---------------------------- Client requests Volume + May 19 01:04:16 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume+ May 19 01:04:16 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:16 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:16 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:16 volumioa thd[752]: [158B blob data] May 19 01:04:16 volumioa thd[752]: {"time":1747587856403,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus May 19 01:04:16 volumioa volumio[4767]: info: Clearing queue after UPNP request May 19 01:04:16 volumioa thd[752]: % Total % Received % Xferd Average Speed Time Time Time Current May 19 01:04:16 volumioa thd[752]: Dload Upload Total Spent Left Speed May 19 01:04:16 volumioa volumio[4767]: info: May 19 01:04:16 volumioa volumio[4767]: ---------------------------- Client requests Volume + May 19 01:04:16 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume+ May 19 01:04:16 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:16 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:16 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:16 volumioa thd[752]: [158B blob data] May 19 01:04:17 volumioa volumio[4767]: info: CoreStateMachine::ClearQueue May 19 01:04:17 volumioa volumio[4767]: info: CoreStateMachine::stop May 19 01:04:17 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 01:04:17 volumioa volumio[4767]: info: CorePlayQueue::clearPlayQueue May 19 01:04:17 volumioa volumio[4767]: info: CorePlayQueue::saveQueue May 19 01:04:17 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:17 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushQueue May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:17 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 13ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 11ms May 19 01:04:17 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 12ms May 19 01:04:17 volumioa volumio[4767]: info: Starting UPNP Playback May 19 01:04:17 volumioa volumio[4767]: info: Preparing playback through UPNP May 19 01:04:17 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetState May 19 01:04:17 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:17 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService mpd May 19 01:04:17 volumioa thd[752]: {"time":1747587856788,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus May 19 01:04:17 volumioa thd[752]: % Total % Received % Xferd Average Speed Time Time Time Current May 19 01:04:17 volumioa thd[752]: Dload Upload Total Spent Left Speed May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- Client requests Volume + May 19 01:04:17 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume+ May 19 01:04:17 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:17 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:17 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:17 volumioa thd[752]: [158B blob data] May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 4ms May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 10ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 11ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 4ms May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: May 19 01:04:17 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:17 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 10ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:17 volumioa volumio[4767]: info: ------------------------------ 4ms May 19 01:04:22 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume70 May 19 01:04:22 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:22 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:22 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:23 volumioa volumio[4767]: info: VolumeController::SetAlsaVolume100 May 19 01:04:23 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:23 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:23 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:24 volumioa volumio[4767]: info: Clearing queue after UPNP request May 19 01:04:24 volumioa volumio[4767]: info: CoreStateMachine::ClearQueue May 19 01:04:24 volumioa volumio[4767]: info: CoreStateMachine::stop May 19 01:04:24 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 01:04:24 volumioa volumio[4767]: info: CorePlayQueue::clearPlayQueue May 19 01:04:24 volumioa volumio[4767]: info: CorePlayQueue::saveQueue May 19 01:04:24 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:24 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushQueue May 19 01:04:24 volumioa volumio[4767]: info: May 19 01:04:24 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:24 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:24 volumioa volumio[4767]: info: May 19 01:04:24 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:24 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:24 volumioa volumio[4767]: info: May 19 01:04:24 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:24 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:24 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:24 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:24 volumioa volumio[4767]: info: ------------------------------ 5ms May 19 01:04:24 volumioa volumio[4767]: info: ------------------------------ 3ms May 19 01:04:24 volumioa volumio[4767]: info: Starting UPNP Playback May 19 01:04:24 volumioa volumio[4767]: info: Preparing playback through UPNP May 19 01:04:24 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetState May 19 01:04:24 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:24 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService mpd May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 10ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 17ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 18ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 14ms May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 12ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 15ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 15ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 10ms May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 4ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 3ms May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:25 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 5ms May 19 01:04:25 volumioa volumio[4767]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 19 01:04:25 volumioa volumio[4767]: info: Retrying Login Due to Network Error May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:25 volumioa mpd[4889]: output: Failed to open mixer for 'default detected output': no such mixer control: PCM May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand status took 36 milliseconds May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand status took 28 milliseconds May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand status took 49 milliseconds May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand status took 27 milliseconds May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 26 milliseconds May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 17 milliseconds May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand status took 13 milliseconds May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:25 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:25 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m801.music.126.net/20250519012924/cf8083f31ec8c1d8d67385910d08000b/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=gdh+mIhZIk6n/RWgA4ns3vbIqeZUucPl2m2nmw727iPNyTpFluDETLcHT5564oKySNJ/z2uwyGkBCPchxb/tEdmyV06sRaIGub4XdXWXNvU=","trackType":""} May 19 01:04:25 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:25 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:25 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m801.music.126.net/20250519012924/cf8083f31ec8c1d8d67385910d08000b/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=gdh+mIhZIk6n/RWgA4ns3vbIqeZUucPl2m2nmw727iPNyTpFluDETLcHT5564oKySNJ/z2uwyGkBCPchxb/tEdmyV06sRaIGub4XdXWXNvU=","trackType":""} May 19 01:04:25 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:25 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 111ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 140ms May 19 01:04:25 volumioa volumio[4767]: info: May 19 01:04:25 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 74 milliseconds May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 75 milliseconds May 19 01:04:25 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 73 milliseconds May 19 01:04:25 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:25 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:25 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m801.music.126.net/20250519012924/cf8083f31ec8c1d8d67385910d08000b/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=gdh+mIhZIk6n/RWgA4ns3vbIqeZUucPl2m2nmw727iPNyTpFluDETLcHT5564oKySNJ/z2uwyGkBCPchxb/tEdmyV06sRaIGub4XdXWXNvU=","trackType":""} May 19 01:04:25 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:25 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:25 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:25 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m801.music.126.net/20250519012924/cf8083f31ec8c1d8d67385910d08000b/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=gdh+mIhZIk6n/RWgA4ns3vbIqeZUucPl2m2nmw727iPNyTpFluDETLcHT5564oKySNJ/z2uwyGkBCPchxb/tEdmyV06sRaIGub4XdXWXNvU=","trackType":""} May 19 01:04:25 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:25 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:25 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:25 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m801.music.126.net/20250519012924/cf8083f31ec8c1d8d67385910d08000b/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=gdh+mIhZIk6n/RWgA4ns3vbIqeZUucPl2m2nmw727iPNyTpFluDETLcHT5564oKySNJ/z2uwyGkBCPchxb/tEdmyV06sRaIGub4XdXWXNvU=","trackType":""} May 19 01:04:25 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:25 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 268ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 255ms May 19 01:04:25 volumioa volumio[4767]: info: ------------------------------ 234ms May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:25 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:25 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:26 volumioa volumio[4767]: info: sendMpdCommand status took 197 milliseconds May 19 01:04:26 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:26 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:26 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 13 milliseconds May 19 01:04:26 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:26 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:26 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:26 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:26 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1479,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m801.music.126.net/20250519012924/cf8083f31ec8c1d8d67385910d08000b/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=gdh+mIhZIk6n/RWgA4ns3vbIqeZUucPl2m2nmw727iPNyTpFluDETLcHT5564oKySNJ/z2uwyGkBCPchxb/tEdmyV06sRaIGub4XdXWXNvU=","trackType":""} May 19 01:04:26 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:26 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:26 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:26 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:26 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:26 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:26 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:26 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:26 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:26 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:26 volumioa volumio[4767]: info: ------------------------------ 306ms May 19 01:04:26 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:26 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:26 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:26 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:26 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:26 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:35 volumioa volumio[4767]: info: MyVolumio login type: Token May 19 01:04:36 volumioa volumio[4767]: info: Clearing queue after UPNP request May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::ClearQueue May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::stop May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::stPlaybackTimer May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::updateTrackBlock May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrackBlock May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::serviceStop May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: ControllerMpd::stop May 19 01:04:37 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand stop May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::clearPlayQueue May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::saveQueue May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushQueue May 19 01:04:37 volumioa mpd[4889]: player: played "http://m801.music.126.net/20250519012924/cf8083f31ec8c1d8d67385910d08000b/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=gdh+mIhZIk6n/RWgA4ns3vbIqeZUucPl2m2nmw727iPNyTpFluDETLcHT5564oKySNJ/z2uwyGkBCPchxb/tEdmyV06sRaIGub4XdXWXNvU=" May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:37 volumioa volumio[4767]: info: sendMpdCommand stop took 50 milliseconds May 19 01:04:37 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:37 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:37 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:37 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:37 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:37 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:37 volumioa volumio[4767]: error: updateQueue error: null May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 13ms May 19 01:04:37 volumioa volumio[4767]: info: sendMpdCommand status took 12 milliseconds May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 11ms May 19 01:04:37 volumioa volumio[4767]: info: sendMpdCommand status took 10 milliseconds May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:37 volumioa volumio[4767]: info: sendMpdCommand status took 6 milliseconds May 19 01:04:37 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:37 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 19 01:04:37 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: No code May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 19 01:04:37 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: No code May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 19 01:04:37 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService stop May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: No code May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 163ms May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 162ms May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 160ms May 19 01:04:37 volumioa volumio[4767]: info: Starting UPNP Playback May 19 01:04:37 volumioa volumio[4767]: info: Preparing playback through UPNP May 19 01:04:37 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetState May 19 01:04:37 volumioa volumio[4767]: info: CorePlayQueue::getTrack 0 May 19 01:04:37 volumioa volumio[4767]: info: CoreStateMachine::setConsumeUpdateService mpd May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:37 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:37 volumioa volumio[4767]: info: May 19 01:04:37 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:37 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 4ms May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 5ms May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 12ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 9ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 8ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 7ms May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: May 19 01:04:38 volumioa volumio[4767]: ---------------------------- MPD announces system playlist update May 19 01:04:38 volumioa volumio[4767]: info: Ignoring MPD Status Update May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 5ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:38 volumioa volumio[4767]: info: ------------------------------ 6ms May 19 01:04:38 volumioa mpd[4889]: exception: Not seekable May 19 01:04:39 volumioa volumio[4767]: info: May 19 01:04:39 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:39 volumioa volumio[4767]: info: May 19 01:04:39 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:39 volumioa volumio[4767]: info: May 19 01:04:39 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:39 volumioa mpd[4889]: output: Failed to open mixer for 'default detected output': no such mixer control: PCM May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:39 volumioa volumio[4767]: info: May 19 01:04:39 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand clearerror May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand status took 27 milliseconds May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand clearerror May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand status took 29 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand clearerror May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand status took 35 milliseconds May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:39 volumioa volumio[4767]: info: May 19 01:04:39 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:39 volumioa volumio[4767]: info: May 19 01:04:39 volumioa volumio[4767]: ---------------------------- MPD announces state update: player May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::getState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand status May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand clearerror took 51 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand clearerror took 46 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand status took 43 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand clearerror took 42 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 17 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 15 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand status took 13 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand status took 11 milliseconds May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseState May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:39 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:39 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m701.music.126.net/20250519012936/11e801306064356b753b5509cca8a519/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=7dN0ruWB8uXxYd5fiy5QYlIv/EB86Oa7uxKLZadAI1YYLHBnn7t4cyGsekDAiGNN3TOO9At4qovyfZiSBtaJdpgFvoOs9p4GcC2no1hsoYI=","trackType":""} May 19 01:04:39 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus stop May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:39 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:39 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m701.music.126.net/20250519012936/11e801306064356b753b5509cca8a519/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=7dN0ruWB8uXxYd5fiy5QYlIv/EB86Oa7uxKLZadAI1YYLHBnn7t4cyGsekDAiGNN3TOO9At4qovyfZiSBtaJdpgFvoOs9p4GcC2no1hsoYI=","trackType":""} May 19 01:04:39 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:39 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:39 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:39 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m701.music.126.net/20250519012936/11e801306064356b753b5509cca8a519/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=7dN0ruWB8uXxYd5fiy5QYlIv/EB86Oa7uxKLZadAI1YYLHBnn7t4cyGsekDAiGNN3TOO9At4qovyfZiSBtaJdpgFvoOs9p4GcC2no1hsoYI=","trackType":""} May 19 01:04:39 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:39 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: ------------------------------ 163ms May 19 01:04:39 volumioa volumio[4767]: info: ------------------------------ 218ms May 19 01:04:39 volumioa volumio[4767]: info: ------------------------------ 216ms May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 137 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 129 milliseconds May 19 01:04:39 volumioa volumio[4767]: info: sendMpdCommand playlistinfo took 132 milliseconds May 19 01:04:39 volumioa volumio[4767]: verbose: ControllerMpd::parseTrackInfo May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:39 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:39 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1479,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m701.music.126.net/20250519012936/11e801306064356b753b5509cca8a519/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=7dN0ruWB8uXxYd5fiy5QYlIv/EB86Oa7uxKLZadAI1YYLHBnn7t4cyGsekDAiGNN3TOO9At4qovyfZiSBtaJdpgFvoOs9p4GcC2no1hsoYI=","trackType":""} May 19 01:04:39 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:39 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:39 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:39 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1479,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m701.music.126.net/20250519012936/11e801306064356b753b5509cca8a519/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=7dN0ruWB8uXxYd5fiy5QYlIv/EB86Oa7uxKLZadAI1YYLHBnn7t4cyGsekDAiGNN3TOO9At4qovyfZiSBtaJdpgFvoOs9p4GcC2no1hsoYI=","trackType":""} May 19 01:04:39 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:39 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: ControllerMpd::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::servicePushState May 19 01:04:39 volumioa volumio[4767]: verbose: In UPNP mode May 19 01:04:39 volumioa volumio[4767]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1479,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"跳楼机","artist":"LBI利比","album":"跳楼机","uri":"http://m701.music.126.net/20250519012936/11e801306064356b753b5509cca8a519/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/59380391029/08cb/6559/bef3/a1a04ca36ab361a51b0e2c7e91ad2084.mp3?vuutv=7dN0ruWB8uXxYd5fiy5QYlIv/EB86Oa7uxKLZadAI1YYLHBnn7t4cyGsekDAiGNN3TOO9At4qovyfZiSBtaJdpgFvoOs9p4GcC2no1hsoYI=","trackType":""} May 19 01:04:39 volumioa volumio[4767]: verbose: CURRENT POSITION 0 May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState stateService play May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::syncState currentStatus play May 19 01:04:39 volumioa volumio[4767]: info: Received an update from plugin. extracting info from payload May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::pushState May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioPushState May 19 01:04:39 volumioa volumio[4767]: info: ------------------------------ 438ms May 19 01:04:39 volumioa volumio[4767]: info: ------------------------------ 376ms May 19 01:04:39 volumioa volumio[4767]: info: ------------------------------ 375ms May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreCommandRouter::volumioGetQueue May 19 01:04:39 volumioa volumio[4767]: info: CoreStateMachine::getQueue May 19 01:04:39 volumioa volumio[4767]: info: CorePlayQueue::getQueue May 19 01:04:47 volumioa ntpd[3571]: 193.182.111.142 local addr 192.168.1.3 -> May 19 01:05:05 volumioa volumio[4767]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 19 01:05:05 volumioa volumio[4767]: info: Retrying Login Due to Network Error May 19 01:05:15 volumioa volumio[4767]: info: MyVolumio login type: Token May 19 01:05:16 volumioa volumio[4767]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 01:05:16 volumioa volumio[4767]: Error: connect ETIMEDOUT 23.234.30.58:443 May 19 01:05:16 volumioa volumio[4767]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 19 01:05:16 volumioa volumio[4767]: errno: -110, May 19 01:05:16 volumioa volumio[4767]: code: 'ETIMEDOUT', May 19 01:05:16 volumioa volumio[4767]: syscall: 'connect', May 19 01:05:16 volumioa volumio[4767]: address: '23.234.30.58', May 19 01:05:16 volumioa volumio[4767]: port: 443 May 19 01:05:16 volumioa volumio[4767]: } May 19 01:05:16 volumioa volumio[4767]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 01:05:17 volumioa sudo[6191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-19 01:04 May 19 01:05:17 volumioa sudo[6191]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"