-- Logs begin at Sun 2024-10-27 19:12:08 CST, end at Sun 2024-10-27 20:28:20 CST. -- Oct 27 20:27:00 volumio volumio[1286]: info: CoreCommandRouter::volumioPlay Oct 27 20:27:00 volumio volumio[1286]: info: CoreStateMachine::play index undefined Oct 27 20:27:00 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:27:00 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:00 volumio volumio[1286]: info: CoreStateMachine::startPlaybackTimer Oct 27 20:27:00 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::clearAddPlayTracks NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3 Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 20:27:00 volumio volumio[1286]: info: sendMpdCommand stop took 2 milliseconds Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 20:27:00 volumio volumio[1286]: info: sendMpdCommand clear took 2 milliseconds Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand add "NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3" Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:27:00 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:27:00 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:27:00 volumio volumio[1286]: info: sendMpdCommand add "NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3" took 6 milliseconds Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand play Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:27:00 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:27:00 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:27:00 volumio volumio[1286]: info: ------------------------------ 14ms Oct 27 20:27:00 volumio volumio[1286]: info: ------------------------------ 14ms Oct 27 20:27:00 volumio volumio[1286]: info: sendMpdCommand play took 10 milliseconds Oct 27 20:27:00 volumio volumio[1286]: info: ------------------------------ 9ms Oct 27 20:27:00 volumio volumio[1286]: info: ------------------------------ 7ms Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:27:00 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:27:00 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:27:00 volumio volumio[1286]: info: ------------------------------ 7ms Oct 27 20:27:00 volumio volumio[1286]: info: ------------------------------ 5ms Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:27:00 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:27:00 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:27:00 volumio volumio[1286]: info: Oct 27 20:27:00 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:27:00 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:27:00 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:27:01 volumio volumio[1286]: info: Oct 27 20:27:01 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand status took 236 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand status took 237 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand status took 235 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand status took 4 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走你的路","artist":"汪峰","album":"拾叁","uri":"NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3","trackType":"mp3"} Oct 27 20:27:01 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop Oct 27 20:27:01 volumio volumio[1286]: info: ------------------------------ 251ms Oct 27 20:27:01 volumio volumio[1286]: info: Oct 27 20:27:01 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:27:01 volumio volumio[1286]: info: Oct 27 20:27:01 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand status took 7 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand status took 3 milliseconds Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走你的路","artist":"汪峰","album":"拾叁","uri":"NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3","trackType":"mp3"} Oct 27 20:27:01 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:27:01 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走你的路","artist":"汪峰","album":"拾叁","uri":"NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3","trackType":"mp3"} Oct 27 20:27:01 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:27:01 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":603,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走你的路","artist":"汪峰","album":"拾叁","uri":"NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3","trackType":"mp3"} Oct 27 20:27:01 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:27:01 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: ------------------------------ 324ms Oct 27 20:27:01 volumio volumio[1286]: info: ------------------------------ 322ms Oct 27 20:27:01 volumio volumio[1286]: info: ------------------------------ 93ms Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 69 milliseconds Oct 27 20:27:01 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 69 milliseconds Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:27:01 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走你的路","artist":"汪峰","album":"拾叁","uri":"NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3","trackType":"mp3"} Oct 27 20:27:01 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:27:01 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走你的路","artist":"汪峰","album":"拾叁","uri":"NAS/网盘A/拾叁/你走你的路 - 汪峰.mp3","trackType":"mp3"} Oct 27 20:27:01 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:27:01 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:27:01 volumio volumio[1286]: info: ------------------------------ 140ms Oct 27 20:27:01 volumio volumio[1286]: info: ------------------------------ 140ms Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 20:27:01 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:01 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:01 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 27 20:27:01 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 27 20:27:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:03 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:03 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 20:27:04 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:04 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:04 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:04 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 20:27:05 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:05 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:05 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:05 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:06 volumio volumio[1286]: info: CoreCommandRouter::volumioGetQueue Oct 27 20:27:06 volumio volumio[1286]: info: CoreStateMachine::getQueue Oct 27 20:27:06 volumio volumio[1286]: info: CorePlayQueue::getQueue Oct 27 20:27:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 20:27:06 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:06 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:06 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:07 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:07 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:07 volumio volumio[1286]: info: Listing playlists Oct 27 20:27:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:07 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:07 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:07 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 27 20:27:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 27 20:27:09 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:27:10 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 27 20:27:10 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:27:13 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 27 20:27:13 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:27:17 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:17 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:18 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 27 20:27:18 volumio volumio[1286]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 27 20:27:18 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 27 20:27:18 volumio volumio[1286]: info: Received Get System Version Oct 27 20:27:18 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 27 20:27:18 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:18 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:18 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:18 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:18 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:18 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:18 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:27 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:27 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:27 volumio volumio[1286]: info: Listing playlists Oct 27 20:27:27 volumio volumio[1286]: info: Listing playlists Oct 27 20:27:33 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:33 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:33 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:33 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:33 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:33 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:37 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:37 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:44 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 27 20:27:44 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:27:47 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:47 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:47 volumio volumio[1286]: info: Listing playlists Oct 27 20:27:47 volumio volumio[1286]: info: Listing playlists Oct 27 20:27:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 27 20:27:49 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/403eceb82d2ec57efdf994e290ae6c9c Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/17c6ac756cb8ec2dc5a3b8eeaa8aec6c Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/29dfd13dce8bc31377291c2dae72ea10 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/420a6120546cecdb34f856d498d32006 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/bf787d5505fd3fc850cecaf61d679661 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/714d9b88b1270903532356aded1d1d44 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/b7b822697db9cf0c39b323a75a287432 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/2e2298200c0b3cc3a7007c50fd02abfc Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/a49866767afd4840ed4e10d9486c0a3e Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/59e88d85ee353305c35e0cf925b49147 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/a3259510529c4fee8ee942cdb2829d1e Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/5a448e38cb7e293f6621766a105ce3c5 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/1cbe24a49821de85bc6c0d3d41a9c0a1 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/4a7c4a7817c589065ae1594bd70e2f75 Oct 27 20:27:49 volumio volumio[1286]: info: Preloading song: volusonic/track/48e78466f683b88685eb07d17deb2b03 Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/403eceb82d2ec57efdf994e290ae6c9c in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/17c6ac756cb8ec2dc5a3b8eeaa8aec6c in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/29dfd13dce8bc31377291c2dae72ea10 in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/420a6120546cecdb34f856d498d32006 in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: No valid Plugin REST Endpoint Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/bf787d5505fd3fc850cecaf61d679661 in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/714d9b88b1270903532356aded1d1d44 in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/b7b822697db9cf0c39b323a75a287432 in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/2e2298200c0b3cc3a7007c50fd02abfc in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/a49866767afd4840ed4e10d9486c0a3e in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/59e88d85ee353305c35e0cf925b49147 in service volusonic Oct 27 20:27:49 volumio volumio[1286]: info: Exploding uri volusonic/track/a3259510529c4fee8ee942cdb2829d1e in service volusonic Oct 27 20:27:50 volumio volumio[1286]: info: Exploding uri volusonic/track/5a448e38cb7e293f6621766a105ce3c5 in service volusonic Oct 27 20:27:50 volumio volumio[1286]: info: Exploding uri volusonic/track/1cbe24a49821de85bc6c0d3d41a9c0a1 in service volusonic Oct 27 20:27:50 volumio volumio[1286]: info: Exploding uri volusonic/track/4a7c4a7817c589065ae1594bd70e2f75 in service volusonic Oct 27 20:27:50 volumio volumio[1286]: info: Exploding uri volusonic/track/48e78466f683b88685eb07d17deb2b03 in service volusonic Oct 27 20:27:54 volumio sudo[6207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 27 20:27:54 volumio sudo[6207]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:27:54 volumio sudo[6207]: pam_unix(sudo:session): session closed for user root Oct 27 20:27:55 volumio sudo[6210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 20:27:55 volumio sudo[6210]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:27:55 volumio sudo[6210]: pam_unix(sudo:session): session closed for user root Oct 27 20:27:55 volumio volumio[1286]: verbose: New Socket.io Connection to 192.168.100.45 from 192.168.100.57 UA: Mozilla/5.0 (Linux; Android 13; iPlay 50 mini Pro Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 27 20:27:55 volumio sudo[6215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 27 20:27:55 volumio sudo[6215]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:27:55 volumio sudo[6215]: pam_unix(sudo:session): session closed for user root Oct 27 20:27:55 volumio sudo[6218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 20:27:55 volumio sudo[6218]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:27:55 volumio sudo[6218]: pam_unix(sudo:session): session closed for user root Oct 27 20:27:55 volumio volumio[1286]: verbose: New Socket.io Connection to 192.168.100.45 from 192.168.100.57 UA: Mozilla/5.0 (Linux; Android 13; iPlay 50 mini Pro Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.58 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::volumioGetVisibleSources Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:55 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::volumioGetQueue Oct 27 20:27:55 volumio volumio[1286]: info: CoreStateMachine::getQueue Oct 27 20:27:55 volumio volumio[1286]: info: CorePlayQueue::getQueue Oct 27 20:27:55 volumio volumio[1286]: info: Listing playlists Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 27 20:27:55 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:55 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:55 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:55 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 27 20:27:55 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 27 20:27:56 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 27 20:27:57 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:57 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:57 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 20:27:57 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:57 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:57 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:57 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:57 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:57 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:57 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:27:57 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 27 20:27:59 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 20:27:59 volumio volumio[1286]: info: Received Get System Info Oct 27 20:27:59 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:27:59 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:27:59 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:27:59 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:27:59 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:27:59 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:28:00 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 27 20:28:00 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/6da3aad9256246d7618e96bffb343a03 Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/ad99da75f29eb9ca28b29801eaeb28f2 Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/850d45a8b9cdefbe1feb7c5f07a81472 Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/48ac3fb981c1af47ddc52c5972464cf1 Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/12dbb3cab1e1cf9451c9ab1e06d0920a Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/3843acf365fd9576ebc3695071f1476b Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/d75f3385f6ae92d9706192e3022d428b Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/c0754d3aed5639e073c2bb70ab4ba861 Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/d92ce5ce6ca65a2e4de86d43cfe381f3 Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/2df51c73c2ff07dbe574f5809a2e3bdb Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/0aeca6cd570696b0967a87a70624cae3 Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/4d0bb4029b82265427d32634f0fb3c5d Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/7c8bdf2e8ae0a7e10bba72d06098b24c Oct 27 20:28:00 volumio volumio[1286]: info: Preloading song: volusonic/track/4563defae3bd061b563649c5eb335234 Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/6da3aad9256246d7618e96bffb343a03 in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/ad99da75f29eb9ca28b29801eaeb28f2 in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: No valid Plugin REST Endpoint Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/850d45a8b9cdefbe1feb7c5f07a81472 in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/48ac3fb981c1af47ddc52c5972464cf1 in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/12dbb3cab1e1cf9451c9ab1e06d0920a in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/3843acf365fd9576ebc3695071f1476b in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/d75f3385f6ae92d9706192e3022d428b in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/c0754d3aed5639e073c2bb70ab4ba861 in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/d92ce5ce6ca65a2e4de86d43cfe381f3 in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/2df51c73c2ff07dbe574f5809a2e3bdb in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/0aeca6cd570696b0967a87a70624cae3 in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/4d0bb4029b82265427d32634f0fb3c5d in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/7c8bdf2e8ae0a7e10bba72d06098b24c in service volusonic Oct 27 20:28:01 volumio volumio[1286]: info: Exploding uri volusonic/track/4563defae3bd061b563649c5eb335234 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:28:03 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:28:03 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::ClearQueue Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::stop Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::stPlaybackTimer Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::updateTrackBlock Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrackBlock Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::serviceStop Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::serviceStop Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::stop Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::clearPlayQueue Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::saveQueue Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPushQueue Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::addQueueItems Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::addQueueItems Oct 27 20:28:03 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/6da3aad9256246d7618e96bffb343a03 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/6da3aad9256246d7618e96bffb343a03 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/ad99da75f29eb9ca28b29801eaeb28f2 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/ad99da75f29eb9ca28b29801eaeb28f2 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/850d45a8b9cdefbe1feb7c5f07a81472 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/850d45a8b9cdefbe1feb7c5f07a81472 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/48ac3fb981c1af47ddc52c5972464cf1 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/48ac3fb981c1af47ddc52c5972464cf1 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/12dbb3cab1e1cf9451c9ab1e06d0920a Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/12dbb3cab1e1cf9451c9ab1e06d0920a in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/3843acf365fd9576ebc3695071f1476b Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/3843acf365fd9576ebc3695071f1476b in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/d75f3385f6ae92d9706192e3022d428b Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/d75f3385f6ae92d9706192e3022d428b in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/c0754d3aed5639e073c2bb70ab4ba861 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/c0754d3aed5639e073c2bb70ab4ba861 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/d92ce5ce6ca65a2e4de86d43cfe381f3 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/d92ce5ce6ca65a2e4de86d43cfe381f3 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/2df51c73c2ff07dbe574f5809a2e3bdb Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/2df51c73c2ff07dbe574f5809a2e3bdb in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/0aeca6cd570696b0967a87a70624cae3 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/0aeca6cd570696b0967a87a70624cae3 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/4d0bb4029b82265427d32634f0fb3c5d Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/4d0bb4029b82265427d32634f0fb3c5d in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/7c8bdf2e8ae0a7e10bba72d06098b24c Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/7c8bdf2e8ae0a7e10bba72d06098b24c in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: Adding Item to queue: volusonic/track/4563defae3bd061b563649c5eb335234 Oct 27 20:28:03 volumio volumio[1286]: info: Exploding uri volusonic/track/4563defae3bd061b563649c5eb335234 in service volusonic Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPushQueue Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::saveQueue Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::updateTrackBlock Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrackBlock Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPlay Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::play index 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::stop Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::play index undefined Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::startPlaybackTimer Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: [1730032083626] ControllerVolusonic::clearAddPlayTrack Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand stop took 169 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand stop took 101 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:03 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 5 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand clear took 5 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.100.111:4533/rest/stream.view?id=6da3aad9256246d7618e96bffb343a03&format=raw&u=admin&p=enc:78696e727569383838&v=1.10.2&f=json&c=volusonic" Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:03 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:03 volumio volumio[1286]: error: updateQueue error: null Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 7 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 6 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 5ms Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:03 volumio volumio[1286]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 49ms Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 49ms Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 53ms Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:03 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:03 volumio volumio[1286]: error: updateQueue error: null Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.111:4533/rest/stream.view?id=6da3aad9256246d7618e96bffb343a03&format=raw&u=admin&p=enc:78696e727569383838&v=1.10.2&f=json&c=volusonic" Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 46ms Oct 27 20:28:03 volumio volumio[1286]: error: updateQueue error: null Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:03 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 7ms Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand add "http://192.168.100.111:4533/rest/stream.view?id=6da3aad9256246d7618e96bffb343a03&format=raw&u=admin&p=enc:78696e727569383838&v=1.10.2&f=json&c=volusonic" took 5 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand play Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:03 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:03 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 6ms Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand play took 4 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 3ms Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: ------------------------------ 4ms Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 2 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:03 volumio volumio[1286]: info: [1730032083799] ControllerVolusonic::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.view?id=6da3aad9256246d7618e96bffb343a03&format=raw&u=admin&p=enc:78696e727569383838&v=1.10.2&f=json&c=volusonic","artist":null,"album":null,"uri":"http://192.168.100.111:4533/rest/stream.view?id=6da3aad9256246d7618e96bffb343a03&format=raw&u=admin&p=enc:78696e727569383838&v=1.10.2&f=json&c=volusonic","trackType":""} Oct 27 20:28:03 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop Oct 27 20:28:03 volumio volumio[1286]: info: [1730032083830] ControllerVolusonic: MPD player state update Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 124 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 123 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 122 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand status took 120 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:03 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:03 volumio volumio[1286]: info: Oct 27 20:28:03 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 27 20:28:03 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:03 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: [1730032083972] ControllerVolusonic::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我的歌声里","artist":"孙露、雷婷、张玮伽","album":"三大发烧女声CD1","uri":"http://192.168.100.111:4533/rest/stream.view?id=6da3aad9256246d7618e96bffb343a03&format=raw&u=admin&p=enc:78696e727569383838&v=1.10.2&f=json&c=volusonic","trackType":""} Oct 27 20:28:03 volumio volumio[1286]: verbose: CURRENT POSITION 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:28:03 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreStateMachine::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState Oct 27 20:28:03 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:03 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:03 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:03 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 183ms Oct 27 20:28:04 volumio volumio[1286]: info: Oct 27 20:28:04 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:04 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:04 volumio volumio[1286]: info: Oct 27 20:28:04 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:04 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:04 volumio volumio[1286]: info: Oct 27 20:28:04 volumio volumio[1286]: ---------------------------- MPD announces system playlist update Oct 27 20:28:04 volumio volumio[1286]: info: Ignoring MPD Status Update Oct 27 20:28:04 volumio volumio[1286]: info: Oct 27 20:28:04 volumio volumio[1286]: ---------------------------- MPD announces state update: player Oct 27 20:28:04 volumio volumio[1286]: info: ControllerMpd::getState Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:28:04 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 64 milliseconds Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 60ms Oct 27 20:28:04 volumio volumio[1286]: info: sendMpdCommand status took 54 milliseconds Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 8ms Oct 27 20:28:04 volumio volumio[1286]: info: sendMpdCommand status took 6 milliseconds Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 5ms Oct 27 20:28:04 volumio volumio[1286]: info: sendMpdCommand status took 5 milliseconds Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::parseState Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:28:04 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:04 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:04 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:04 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:04 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:04 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:04 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:04 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 195ms Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 193ms Oct 27 20:28:04 volumio volumio[1286]: info: CoreCommandRouter::volumioGetQueue Oct 27 20:28:04 volumio volumio[1286]: info: CoreStateMachine::getQueue Oct 27 20:28:04 volumio volumio[1286]: info: CorePlayQueue::getQueue Oct 27 20:28:04 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 43 milliseconds Oct 27 20:28:04 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 43 milliseconds Oct 27 20:28:04 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 43 milliseconds Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:04 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:28:04 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:04 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:04 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:04 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:04 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:04 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:04 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:04 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:04 volumio volumio[1286]: info: ControllerMpd::pushState Oct 27 20:28:04 volumio volumio[1286]: info: CoreCommandRouter::servicePushState Oct 27 20:28:04 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:04 volumio volumio[1286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 109ms Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 55ms Oct 27 20:28:04 volumio volumio[1286]: info: ------------------------------ 52ms Oct 27 20:28:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 27 20:28:07 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:28:07 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:07 volumio volumio[1286]: info: Listing playlists Oct 27 20:28:07 volumio volumio[1286]: info: Listing playlists Oct 27 20:28:14 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 27 20:28:14 volumio volumio[1286]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 27 20:28:14 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 27 20:28:14 volumio volumio[1286]: info: Received Get System Version Oct 27 20:28:14 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 27 20:28:14 volumio volumio[1286]: info: Received Get System Info Oct 27 20:28:14 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:28:14 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:28:14 volumio volumio[1286]: info: Discovery: Getting this device information Oct 27 20:28:14 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:28:14 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:14 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 20:28:17 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Oct 27 20:28:17 volumio volumio[1286]: info: Preload queue cleared Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/22b8a86987801719e7355fb605a32671 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/873a3ee445819c79e4d8ed438f0a1f37 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/d59110defef5e34c831c5ffdc0aa6494 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/08b0fef87ead7fe26c59b105f83eb946 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/cd0678e00409e88eec5aecf5899e4902 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/43e7f8aa27bc6063cf99331c8e97d57a Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/108fe54f3d12de924f2c2f786a5c68c5 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/11a25057eb86860990ba8923422ec92f Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/fda82d55e234eb5383db2b25758e88a4 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/c6953681d2afa9558b8c7b495e88473b Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/14c92c977fa13ad61c1d7f0ded623abd Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/3089b0d7940f2fa6a095d4aafa6f2b28 Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/6d375e71c978a0e6e3c55a7393abd16e Oct 27 20:28:17 volumio volumio[1286]: info: Preloading song: volusonic/track/92da6eec18a5c70bb5d629a5ac46516b Oct 27 20:28:17 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState Oct 27 20:28:17 volumio volumio[1286]: info: CorePlayQueue::getTrack 0 Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/22b8a86987801719e7355fb605a32671 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/873a3ee445819c79e4d8ed438f0a1f37 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/d59110defef5e34c831c5ffdc0aa6494 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/08b0fef87ead7fe26c59b105f83eb946 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: No valid Plugin REST Endpoint Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/cd0678e00409e88eec5aecf5899e4902 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/43e7f8aa27bc6063cf99331c8e97d57a in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/108fe54f3d12de924f2c2f786a5c68c5 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/11a25057eb86860990ba8923422ec92f in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/fda82d55e234eb5383db2b25758e88a4 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/c6953681d2afa9558b8c7b495e88473b in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/14c92c977fa13ad61c1d7f0ded623abd in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/3089b0d7940f2fa6a095d4aafa6f2b28 in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/6d375e71c978a0e6e3c55a7393abd16e in service volusonic Oct 27 20:28:17 volumio volumio[1286]: info: Exploding uri volusonic/track/92da6eec18a5c70bb5d629a5ac46516b in service volusonic Oct 27 20:28:20 volumio volumio[1286]: info: Adding volusonic/track/d59110defef5e34c831c5ffdc0aa6494 to favourites with specific volusonic method Oct 27 20:28:20 volumio volumio[1286]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 20:28:20 volumio volumio[1286]: TypeError: Cannot read property 'then' of undefined Oct 27 20:28:20 volumio volumio[1286]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:679:20) Oct 27 20:28:20 volumio volumio[1286]: at Socket.emit (events.js:400:28) Oct 27 20:28:20 volumio volumio[1286]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 27 20:28:20 volumio volumio[1286]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 27 20:28:20 volumio volumio[1286]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 20:28:20 volumio sudo[6286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-27 20:27 Oct 27 20:28:20 volumio sudo[6286]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"