-- Logs begin at Thu 2020-09-24 20:42:43 UTC, end at Thu 2024-05-09 15:11:50 UTC. -- May 09 15:10:01 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:10:01 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:10:01 xxxxx volumio[17453]: info: Discovery: Getting this device information May 09 15:10:01 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetState May 09 15:10:01 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 09 15:10:01 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 09 15:10:01 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 09 15:10:06 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 15:10:06 xxxxx volumio[17453]: info: CURURI: playlists/02老民谣 May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::ClearQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:08 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::stPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::updateTrackBlock May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrackBlock May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::serviceStop May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::serviceStop May 09 15:10:08 xxxxx volumio[17453]: info: [1715267408280] ControllerUPNPBrowser::stop May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::clearPlayQueue May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::saveQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::addQueueItems May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::addQueueItems May 09 15:10:08 xxxxx volumio[17453]: info: Adding Item to queue: upnp/folder/http://192.168.31.156:1487/ContentDirectory/1de05a06-dcbe-d2ff-b4ad-3c34de1dd10e/control.xml@smb://192.168.1.31/123/音乐/校园民谣珍藏版 1993-2002 3CD/disk2/ May 09 15:10:08 xxxxx volumio[17453]: info: Exploding uri upnp/folder/http://192.168.31.156:1487/ContentDirectory/1de05a06-dcbe-d2ff-b4ad-3c34de1dd10e/control.xml@smb://192.168.1.31/123/音乐/校园民谣珍藏版 1993-2002 3CD/disk2/ in service upnp_browser May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:08 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:08 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:08 xxxxx volumio[17453]: 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":"06%2520-%2520%25e7%259d%25a1%25e5%259c%25a8%25e6%2588%2591%25e4%25b8%258a%25e9%2593%25ba%25e7%259a%2584%25e5%2585%2584%25e5%25bc%259f%2520-%2520%25e8%2580%2581%25e7%258b%25bc.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/516b066041e65f15a895452140f7765e/06%2520-%2520%25e7%259d%25a1%25e5%259c%25a8%25e6%2588%2591%25e4%25b8%258a%25e9%2593%25ba%25e7%259a%2584%25e5%2585%2584%25e5%25bc%259f%2520-%2520%25e8%2580%2581%25e7%258b%25bc.flac","trackType":"flac"} May 09 15:10:08 xxxxx volumio[17453]: verbose: CURRENT POSITION 8 May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService stop May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: No code May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 13ms May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::saveQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::updateTrackBlock May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrackBlock May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPlay May 09 15:10:08 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::play index 0 May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:08 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::play index undefined May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:08 xxxxx volumio[17453]: info: [1715267408414] ControllerUPNPBrowser::clearAddPlayTrack May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:08 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:08 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/416eec2b146d7efcc4700be20d08ad27/06%2520-%2520%25e8%2580%2581%25e5%25b1%258b%2520-%2520%25e8%2580%2581%25e5%25b1%258b.flac" May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 5ms May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.156:1487/%25/a23c013ede8e283b6eeec53659d4144e/01%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad.flac" May 09 15:10:08 xxxxx volumio[17453]: error: updateQueue error: null May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 80ms May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/a23c013ede8e283b6eeec53659d4144e/01%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad.flac" May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand play May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:08 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:08 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/367d820958853b96547bd3a5e3d982c2/02%2520-%2520%25e5%2585%25b3%25e4%25ba%258e%25e7%2590%2586%25e6%2583%25b3%25e7%259a%2584%25e8%25af%25be%25e5%25a0%2582%25e4%25bd%259c%25e4%25b8%259a%2520-%2520%25e5%2585%25b3%25e4%25ba%258e%25e7%2590%2586%25e6%2583%25b3%25e7%259a%2584%25e8%25af%25be%25e5%25a0%2582%25e4%25bd%259c%25e4%25b8%259a.flac" May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:08 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:08 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/a77adb80d971a2302c564705e9e18531/10%2520-%2520%25e5%2590%258c%25e6%25a1%258c%25e7%259a%2584%25e4%25bd%25a0%25ef%25bc%2588%25e4%25bc%25b4%25e5%25a5%258f%25e7%2589%2588%25ef%25bc%2589%2520-%2520%25e5%2590%258c%25e6%25a1%258c%25e7%259a%2584%25e4%25bd%25a0%25ef%25bc%2588%25e4%25bc%25b4%25e5%25a5%258f%25e7%2589%2588%25ef%25bc%2589.flac" May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:08 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:08 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/5e05e20da602f79b7ae54458bc00841f/08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac" May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:08 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:08 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:08 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:08 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/a23c013ede8e283b6eeec53659d4144e/01%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad.flac","trackType":"flac"} May 09 15:10:08 xxxxx volumio[17453]: verbose: CURRENT POSITION 7 May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 9ms May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 7ms May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:08 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:08 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":185,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"772 Kbps","isStreaming":false,"title":"01%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/a23c013ede8e283b6eeec53659d4144e/01%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad.flac","trackType":"flac"} May 09 15:10:08 xxxxx volumio[17453]: verbose: CURRENT POSITION 7 May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus play May 09 15:10:08 xxxxx volumio[17453]: info: Received an update from plugin. extracting info from payload May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 34ms May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:08 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:08 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/b250274981ef434feafced88e1c85ada/04%2520-%2520%25e6%2598%2594%25e6%2597%25a5%25e9%2587%258d%25e6%259d%25a5%2520-%2520%25e6%2598%2594%25e6%2597%25a5%25e9%2587%258d%25e6%259d%25a5.flac" May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:08 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:08 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/c6491fdab54ffa6fb8db963a882a5335/03%2520-%2520%25e8%25bf%2599%25e7%25a7%258d%25e5%25bf%2583%25e6%2583%2585%2520-%2520%25e8%25bf%2599%25e7%25a7%258d%25e5%25bf%2583%25e6%2583%2585.flac" May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:08 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:08 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/eb7565a6bc5b798de8bcfba0864e0c97/07%2520-%2520%25e6%259c%2580%25e5%2590%258e%2520-%2520%25e6%259c%2580%25e5%2590%258e.flac" May 09 15:10:08 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:08 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: info: May 09 15:10:08 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:08 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:08 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:08 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:09 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:09 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:09 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/f2b54103f30cda95f3f70f2feec63bed/09%2520-%2520%25e6%25b2%25a1%25e6%259c%2589%25e6%2583%25b3%25e6%25b3%2595%2520-%2520%25e6%25b2%25a1%25e6%259c%2589%25e6%2583%25b3%25e6%25b3%2595.flac" May 09 15:10:09 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:09 xxxxx volumio[17453]: info: May 09 15:10:09 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:09 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:09 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:09 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:09 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:09 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:09 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/afdcf7d9d01668c685e09ec536b07e03/05%2520-%2520%25e7%25ba%25a2%25e8%2589%25b2%25e5%25a4%25a9%25e7%25a9%25ba%2520-%2520%25e7%25ba%25a2%25e8%2589%25b2%25e5%25a4%25a9%25e7%25a9%25ba.flac" May 09 15:10:09 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:09 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 10 May 09 15:10:09 xxxxx volumio[17453]: info: May 09 15:10:09 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:09 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:09 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:09 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:10 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:10:10 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:10:10 xxxxx volumio[17453]: info: Discovery: Getting this device information May 09 15:10:10 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetState May 09 15:10:10 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 09 15:10:10 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 09 15:10:10 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPlay May 09 15:10:18 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::play index 7 May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:18 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::stPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::updateTrackBlock May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrackBlock May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::serviceStop May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::serviceStop May 09 15:10:18 xxxxx volumio[17453]: info: [1715267418184] ControllerUPNPBrowser::stop May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::play index undefined May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:18 xxxxx volumio[17453]: info: [1715267418198] ControllerUPNPBrowser::clearAddPlayTrack May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:18 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.156:1487/%25/5e05e20da602f79b7ae54458bc00841f/08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac" May 09 15:10:18 xxxxx volumio[17453]: error: updateQueue error: null May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:18 xxxxx volumio[17453]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 4ms May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/5e05e20da602f79b7ae54458bc00841f/08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac" May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand play May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/a77adb80d971a2302c564705e9e18531/10%2520-%2520%25e5%2590%258c%25e6%25a1%258c%25e7%259a%2584%25e4%25bd%25a0%25ef%25bc%2588%25e4%25bc%25b4%25e5%25a5%258f%25e7%2589%2588%25ef%25bc%2589%2520-%2520%25e5%2590%258c%25e6%25a1%258c%25e7%259a%2584%25e4%25bd%25a0%25ef%25bc%2588%25e4%25bc%25b4%25e5%25a5%258f%25e7%2589%2588%25ef%25bc%2589.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/eb7565a6bc5b798de8bcfba0864e0c97/07%2520-%2520%25e6%259c%2580%25e5%2590%258e%2520-%2520%25e6%259c%2580%25e5%2590%258e.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/b250274981ef434feafced88e1c85ada/04%2520-%2520%25e6%2598%2594%25e6%2597%25a5%25e9%2587%258d%25e6%259d%25a5%2520-%2520%25e6%2598%2594%25e6%2597%25a5%25e9%2587%258d%25e6%259d%25a5.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:18 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:18 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:18 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:18 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"511 Kbps","isStreaming":false,"title":"08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/5e05e20da602f79b7ae54458bc00841f/08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac","trackType":"flac"} May 09 15:10:18 xxxxx volumio[17453]: verbose: CURRENT POSITION 3 May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:18 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:18 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":139,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"529 Kbps","isStreaming":false,"title":"08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/5e05e20da602f79b7ae54458bc00841f/08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac","trackType":"flac"} May 09 15:10:18 xxxxx volumio[17453]: verbose: CURRENT POSITION 3 May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus play May 09 15:10:18 xxxxx volumio[17453]: info: Received an update from plugin. extracting info from payload May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 14ms May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 14ms May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:18 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/f2b54103f30cda95f3f70f2feec63bed/09%2520-%2520%25e6%25b2%25a1%25e6%259c%2589%25e6%2583%25b3%25e6%25b3%2595%2520-%2520%25e6%25b2%25a1%25e6%259c%2589%25e6%2583%25b3%25e6%25b3%2595.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/416eec2b146d7efcc4700be20d08ad27/06%2520-%2520%25e8%2580%2581%25e5%25b1%258b%2520-%2520%25e8%2580%2581%25e5%25b1%258b.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/afdcf7d9d01668c685e09ec536b07e03/05%2520-%2520%25e7%25ba%25a2%25e8%2589%25b2%25e5%25a4%25a9%25e7%25a9%25ba%2520-%2520%25e7%25ba%25a2%25e8%2589%25b2%25e5%25a4%25a9%25e7%25a9%25ba.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/367d820958853b96547bd3a5e3d982c2/02%2520-%2520%25e5%2585%25b3%25e4%25ba%258e%25e7%2590%2586%25e6%2583%25b3%25e7%259a%2584%25e8%25af%25be%25e5%25a0%2582%25e4%25bd%259c%25e4%25b8%259a%2520-%2520%25e5%2585%25b3%25e4%25ba%258e%25e7%2590%2586%25e6%2583%25b3%25e7%259a%2584%25e8%25af%25be%25e5%25a0%2582%25e4%25bd%259c%25e4%25b8%259a.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/c6491fdab54ffa6fb8db963a882a5335/03%2520-%2520%25e8%25bf%2599%25e7%25a7%258d%25e5%25bf%2583%25e6%2583%2585%2520-%2520%25e8%25bf%2599%25e7%25a7%258d%25e5%25bf%2583%25e6%2583%2585.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:18 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:18 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/a23c013ede8e283b6eeec53659d4144e/01%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad%2520-%2520%25e5%2586%25ac%25e5%25ad%25a3%25e6%25a0%25a1%25e5%259b%25ad.flac" May 09 15:10:18 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:18 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:18 xxxxx volumio[17453]: info: May 09 15:10:18 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:18 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:18 xxxxx volumio[17453]: info: ------------------------------ 6ms May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:18 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 10 May 09 15:10:22 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 15:10:22 xxxxx volumio[17453]: info: CURURI: playlists/03老民谣 May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::ClearQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:30 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::stPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::updateTrackBlock May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrackBlock May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::serviceStop May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::serviceStop May 09 15:10:30 xxxxx volumio[17453]: info: [1715267430286] ControllerUPNPBrowser::stop May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::clearPlayQueue May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::saveQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::addQueueItems May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::addQueueItems May 09 15:10:30 xxxxx volumio[17453]: info: Adding Item to queue: upnp/folder/http://192.168.31.156:1487/ContentDirectory/1de05a06-dcbe-d2ff-b4ad-3c34de1dd10e/control.xml@smb://192.168.1.31/123/音乐/校园民谣珍藏版 1993-2002 3CD/disk3/ May 09 15:10:30 xxxxx volumio[17453]: info: Exploding uri upnp/folder/http://192.168.31.156:1487/ContentDirectory/1de05a06-dcbe-d2ff-b4ad-3c34de1dd10e/control.xml@smb://192.168.1.31/123/音乐/校园民谣珍藏版 1993-2002 3CD/disk3/ in service upnp_browser May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:30 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:30 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: 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":"08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/5e05e20da602f79b7ae54458bc00841f/08%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0%2520-%2520%25e6%2583%25b3%25e4%25bd%25a0.flac","trackType":"flac"} May 09 15:10:30 xxxxx volumio[17453]: verbose: CURRENT POSITION 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService stop May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: No code May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 12ms May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::saveQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::updateTrackBlock May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrackBlock May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPlay May 09 15:10:30 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::play index 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:30 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::play index undefined May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: [1715267430404] ControllerUPNPBrowser::clearAddPlayTrack May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.156:1487/%25/60d21375932e0c68a4b1aa4f5fbf3ecd/01%2520-%2520%25e6%2583%2585%25e6%2584%259f%25e5%25be%2580%25e4%25ba%258b%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:30 xxxxx volumio[17453]: error: updateQueue error: null May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/0fd68145241b1408e17aba046fca6d5c/02%2520-%2520%25e4%25bd%25a0%25e6%2598%25af%25e6%259c%258b%25e5%258f%258b%25e5%2590%2597%2520-%2520%25e6%259d%258e%25e6%2599%2593%25e4%25b8%259c.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/91de2dd8e44d2d1ccedebfdca2a25359/04%2520-%2520%25e9%259d%2592%25e6%2598%25a5%25e5%2590%258c%25e8%25b7%25af%25e4%25ba%25ba%2520-%2520%25e4%25b8%2581%25e8%2596%2587%25e3%2580%2581%25e6%259d%258e%25e6%2599%2593%25e4%25b8%259c%25e3%2580%2581%25e7%25a6%25b9%25e8%2583%25a7%25e3%2580%2581%25e6%259d%258e%25e8%2593%2589.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/60d21375932e0c68a4b1aa4f5fbf3ecd/01%2520-%2520%25e6%2583%2585%25e6%2584%259f%25e5%25be%2580%25e4%25ba%258b%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand play May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/b31388b3942aa11e3cc654c33b8c1e42/09%2520-%2520%25e4%25b8%258a%25e5%25ad%25a6%25c2%25b7%25e4%25b8%258a%25e7%258f%25ad%2520-%2520%25e4%25bc%2597%25e6%25ad%258c%25e6%2589%258b.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:30 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:30 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:30 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:30 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"131 Kbps","isStreaming":false,"title":"03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","trackType":"flac"} May 09 15:10:30 xxxxx volumio[17453]: verbose: CURRENT POSITION 8 May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 13ms May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:30 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:30 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":232,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"325 Kbps","isStreaming":false,"title":"03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","trackType":"flac"} May 09 15:10:30 xxxxx volumio[17453]: verbose: CURRENT POSITION 8 May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus play May 09 15:10:30 xxxxx volumio[17453]: info: Received an update from plugin. extracting info from payload May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 23ms May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/6cf3d13b5ee3dfa1df85f53d3cac19a7/07%2520-%2520%25e7%2590%2586%25e6%2583%25b3%25e4%25b8%25bb%25e4%25b9%2589%25c2%25b7EMPTY%2520-%2520%25e5%2591%25a8%25e6%2596%2587%25e5%25ae%258f.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/ccfb97d999f9920d1b7c4fba94a142ce/06%2520-%2520%25e4%25b8%258d%25e5%25ae%2589%2520-%2520%25e6%259d%258e%25e6%2599%2593%25e4%25b8%259c.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/1e183f4b692c9202badc3b45a0cc3ef3/05%2520-%2520%25e5%2588%259d%25e6%2581%258b%2520-%2520%25e5%25aa%259b%25e5%25aa%259b.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:30 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:30 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/b7b9290ea5eebd5b5facd0581448f705/08%2520-%2520%25e6%2583%2585%25e4%25ba%25ba%2520-%2520%25e5%2588%2598%25e8%2588%25aa.flac" May 09 15:10:30 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:30 xxxxx volumio[17453]: info: May 09 15:10:30 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:30 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:30 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:30 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:30 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:38 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPlay May 09 15:10:38 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::play index 2 May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:38 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::stPlaybackTimer May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::updateTrackBlock May 09 15:10:38 xxxxx volumio[17453]: info: CorePlayQueue::getTrackBlock May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:38 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:38 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:38 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:38 xxxxx volumio[17453]: info: CoreStateMachine::serviceStop May 09 15:10:38 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:38 xxxxx volumio[17453]: info: CoreCommandRouter::serviceStop May 09 15:10:38 xxxxx volumio[17453]: info: [1715267438968] ControllerUPNPBrowser::stop May 09 15:10:38 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::play index undefined May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:39 xxxxx volumio[17453]: info: [1715267439056] ControllerUPNPBrowser::clearAddPlayTrack May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:39 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:39 xxxxx volumio[17453]: error: updateQueue error: null May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:39 xxxxx volumio[17453]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 8ms May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand play May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/ccfb97d999f9920d1b7c4fba94a142ce/06%2520-%2520%25e4%25b8%258d%25e5%25ae%2589%2520-%2520%25e6%259d%258e%25e6%2599%2593%25e4%25b8%259c.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/91de2dd8e44d2d1ccedebfdca2a25359/04%2520-%2520%25e9%259d%2592%25e6%2598%25a5%25e5%2590%258c%25e8%25b7%25af%25e4%25ba%25ba%2520-%2520%25e4%25b8%2581%25e8%2596%2587%25e3%2580%2581%25e6%259d%258e%25e6%2599%2593%25e4%25b8%259c%25e3%2580%2581%25e7%25a6%25b9%25e8%2583%25a7%25e3%2580%2581%25e6%259d%258e%25e8%2593%2589.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 3 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/6cf3d13b5ee3dfa1df85f53d3cac19a7/07%2520-%2520%25e7%2590%2586%25e6%2583%25b3%25e4%25b8%25bb%25e4%25b9%2589%25c2%25b7EMPTY%2520-%2520%25e5%2591%25a8%25e6%2596%2587%25e5%25ae%258f.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 6 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/1e183f4b692c9202badc3b45a0cc3ef3/05%2520-%2520%25e5%2588%259d%25e6%2581%258b%2520-%2520%25e5%25aa%259b%25e5%25aa%259b.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:39 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:39 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:39 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:39 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":278,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"327 Kbps","isStreaming":false,"title":"03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","trackType":"flac"} May 09 15:10:39 xxxxx volumio[17453]: verbose: CURRENT POSITION 4 May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 8ms May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:39 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:39 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":325,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"327 Kbps","isStreaming":false,"title":"03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","trackType":"flac"} May 09 15:10:39 xxxxx volumio[17453]: verbose: CURRENT POSITION 4 May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus play May 09 15:10:39 xxxxx volumio[17453]: info: Received an update from plugin. extracting info from payload May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 14ms May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:39 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 4 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/0fd68145241b1408e17aba046fca6d5c/02%2520-%2520%25e4%25bd%25a0%25e6%2598%25af%25e6%259c%258b%25e5%258f%258b%25e5%2590%2597%2520-%2520%25e6%259d%258e%25e6%2599%2593%25e4%25b8%259c.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/b7b9290ea5eebd5b5facd0581448f705/08%2520-%2520%25e6%2583%2585%25e4%25ba%25ba%2520-%2520%25e5%2588%2598%25e8%2588%25aa.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 7 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/b31388b3942aa11e3cc654c33b8c1e42/09%2520-%2520%25e4%25b8%258a%25e5%25ad%25a6%25c2%25b7%25e4%25b8%258a%25e7%258f%25ad%2520-%2520%25e4%25bc%2597%25e6%25ad%258c%25e6%2589%258b.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 8 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:39 xxxxx volumio[17453]: info: Prefetching next song May 09 15:10:39 xxxxx volumio[17453]: info: Doing Prefetch in UPNP May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/60d21375932e0c68a4b1aa4f5fbf3ecd/01%2520-%2520%25e6%2583%2585%25e6%2584%259f%25e5%25be%2580%25e4%25ba%258b%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:39 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: info: May 09 15:10:39 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:39 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:39 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:39 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 9 May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPlay May 09 15:10:46 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::play index 2 May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:46 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::stPlaybackTimer May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::updateTrackBlock May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrackBlock May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::serviceStop May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::serviceStop May 09 15:10:46 xxxxx volumio[17453]: info: [1715267446047] ControllerUPNPBrowser::stop May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:46 xxxxx volumio[17453]: info: May 09 15:10:46 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:10:46 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::play index undefined May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::startPlaybackTimer May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:46 xxxxx volumio[17453]: info: [1715267446117] ControllerUPNPBrowser::clearAddPlayTrack May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:10:46 xxxxx volumio[17453]: info: May 09 15:10:46 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:46 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:46 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:46 xxxxx volumio[17453]: 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":"03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","trackType":"flac"} May 09 15:10:46 xxxxx volumio[17453]: verbose: CURRENT POSITION 2 May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService stop May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:46 xxxxx volumio[17453]: info: No code May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:10:46 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:10:46 xxxxx volumio[17453]: info: ------------------------------ 16ms May 09 15:10:46 xxxxx volumio[17453]: error: updateQueue error: null May 09 15:10:46 xxxxx volumio[17453]: info: ------------------------------ 10ms May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac" May 09 15:10:46 xxxxx volumio[17453]: info: May 09 15:10:46 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:10:46 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:10:46 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 15:10:46 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand play May 09 15:10:46 xxxxx volumio[17453]: info: ------------------------------ 2ms May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 2 May 09 15:10:46 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 5 May 09 15:11:15 xxxxx systemd-journal[220]: Suppressed 149 messages from /system.slice/volumio.service May 09 15:11:15 xxxxx volumio[17453]: info: May 09 15:11:15 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:11:15 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:11:15 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:11:15 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:11:15 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:11:15 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:11:15 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:11:15 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:11:15 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:11:15 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:11:15 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:11:15 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 1 May 09 15:11:15 xxxxx volumio[17453]: 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":"03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","artist":"群星","album":"校园民谣","uri":"http://192.168.31.156:1487/%25/dc878829458d045d8afdc5efe78da679/03%2520-%2520%25e4%25bd%25a0%25e4%25b8%258d%25e5%259c%25a8%25e7%259a%2584%25e5%258c%2597%25e4%25ba%25ac%25e8%25bf%2598%25e4%25b8%258b%25e7%259d%2580%25e9%259b%25a8%2520-%2520%25e8%2592%258b%25e6%25a2%2585.flac","trackType":"flac"} May 09 15:11:15 xxxxx volumio[17453]: verbose: CURRENT POSITION 1 May 09 15:11:15 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService stop May 09 15:11:15 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus play May 09 15:11:15 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:11:15 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:11:15 xxxxx volumio[17453]: info: CoreStateMachine::stPlaybackTimer May 09 15:11:15 xxxxx volumio[17453]: info: ------------------------------ 11ms May 09 15:11:15 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:11:15 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:11:15 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:11:15 xxxxx volumio[17453]: info: Clearing queue after UPNP request May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::ClearQueue May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::stop May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:11:16 xxxxx volumio[17453]: UNSET VOLATILE May 09 15:11:16 xxxxx volumio[17453]: info: CorePlayQueue::clearPlayQueue May 09 15:11:16 xxxxx volumio[17453]: info: CorePlayQueue::saveQueue May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushQueue May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: error: updateQueue error: null May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:11:16 xxxxx volumio[17453]: info: Starting UPNP Playback May 09 15:11:16 xxxxx volumio[17453]: info: Preparing playback through UPNP May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetState May 09 15:11:16 xxxxx volumio[17453]: info: CorePlayQueue::getTrack 0 May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 0ms May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 1ms May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:11:16 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces state update: player May 09 15:11:16 xxxxx volumio[17453]: info: May 09 15:11:16 xxxxx volumio[17453]: ---------------------------- MPD announces system playlist update May 09 15:11:16 xxxxx volumio[17453]: info: Ignoring MPD Status Update May 09 15:11:16 xxxxx volumio[17453]: info: ControllerMpd::getState May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand status May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:11:16 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:11:16 xxxxx volumio[17453]: In UPNP mode May 09 15:11:16 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"385 Kbps","isStreaming":false,"title":"渡口","artist":"蔡琴","album":"民歌蔡琴","uri":"http://118.123.167.189/amobile.music.tc.qq.com/F0000041aqiP3k8MYA.flac?guid=0000000052c67b170000017b9ba5b73a&vkey=8067B0E62B8F7526D567282E066A2066C8B776623A567759D6F7FA01380D8D4BD6F0642902CCEA4CAEB70870197D5989484956D4F415832E&uin=317524287&redirect=1&fromtag=111114","trackType":""} May 09 15:11:16 xxxxx volumio[17453]: verbose: CURRENT POSITION 0 May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus stop May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 11ms May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 11ms May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::parseState May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:11:16 xxxxx volumio[17453]: verbose: ControllerMpd::parseTrackInfo May 09 15:11:16 xxxxx volumio[17453]: info: ControllerMpd::pushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::servicePushState May 09 15:11:16 xxxxx volumio[17453]: In UPNP mode May 09 15:11:16 xxxxx volumio[17453]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"356 Kbps","isStreaming":false,"title":"渡口","artist":"蔡琴","album":"民歌蔡琴","uri":"http://118.123.167.189/amobile.music.tc.qq.com/F0000041aqiP3k8MYA.flac?guid=0000000052c67b170000017b9ba5b73a&vkey=8067B0E62B8F7526D567282E066A2066C8B776623A567759D6F7FA01380D8D4BD6F0642902CCEA4CAEB70870197D5989484956D4F415832E&uin=317524287&redirect=1&fromtag=111114","trackType":""} May 09 15:11:16 xxxxx volumio[17453]: verbose: CURRENT POSITION 0 May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::syncState stateService play May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::syncState currentStatus play May 09 15:11:16 xxxxx volumio[17453]: info: Received an update from plugin. extracting info from payload May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::pushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioPushState May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:11:16 xxxxx volumio[17453]: info: ------------------------------ 33ms May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:11:16 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:11:16 xxxxx volumio[17453]: info: CoreCommandRouter::volumioGetQueue May 09 15:11:16 xxxxx volumio[17453]: info: CoreStateMachine::getQueue May 09 15:11:16 xxxxx volumio[17453]: info: CorePlayQueue::getQueue May 09 15:11:49 xxxxx volumio[17453]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 15:11:49 xxxxx volumio[17453]: { Error: connect ETIMEDOUT 162.125.32.9:443 May 09 15:11:49 xxxxx volumio[17453]: at Object._errnoException (util.js:1022:11) May 09 15:11:49 xxxxx volumio[17453]: at _exceptionWithHostPort (util.js:1044:20) May 09 15:11:49 xxxxx volumio[17453]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 09 15:11:49 xxxxx volumio[17453]: code: 'ETIMEDOUT', May 09 15:11:49 xxxxx volumio[17453]: errno: 'ETIMEDOUT', May 09 15:11:49 xxxxx volumio[17453]: syscall: 'connect', May 09 15:11:49 xxxxx volumio[17453]: address: '162.125.32.9', May 09 15:11:49 xxxxx volumio[17453]: port: 443 } May 09 15:11:49 xxxxx volumio[17453]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 15:11:50 xxxxx sudo[28731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-09 15:10 May 09 15:11:50 xxxxx sudo[28731]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"