-- Logs begin at Thu 2024-03-21 23:28:12 CST, end at Sat 2024-03-30 10:50:13 CST. --
Mar 30 10:49:28 VTS volumio[23312]: info:
Mar 30 10:49:28 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:49:28 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:49:28 VTS volumio[23312]: info:
Mar 30 10:49:28 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:49:28 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:49:28 VTS volumio[23312]: info:
Mar 30 10:49:28 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:49:28 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:49:28 VTS volumio[23312]: info: sendMpdCommand status took 3 milliseconds
Mar 30 10:49:28 VTS volumio[23312]: info: sendMpdCommand status took 2 milliseconds
Mar 30 10:49:28 VTS volumio[23312]: info: sendMpdCommand status took 2 milliseconds
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:49:28 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 30 10:49:28 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 30 10:49:28 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:49:28 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:49:28 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:49:28 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:49:28 VTS volumio[23312]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85227,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"817 Kbps","isStreaming":false,"title":"Find Your Way","artist":"In Color","album":"In Color (the Lamp Album)","uri":"http://58.222.38.160/amobile.music.tc.qq.com/F000001kl8h32gv5HN.flac?guid=930B11B52D8045C09D9BCF572C729CF0&vkey=E3419FA265BD365086697859CB3FE52C86B1EB43319B0502111C86CF7EB61559ECEE1806A72B08E334D986D5401CE874D549EFD3BCAE5ED9&uin=1152921504616111776&redirect=1&fromtag=101114","trackType":""}
Mar 30 10:49:28 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::syncState stateService pause
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::stPlaybackTimer
Mar 30 10:49:28 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:49:28 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:49:28 VTS volumio[23312]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85227,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"817 Kbps","isStreaming":false,"title":"Find Your Way","artist":"In Color","album":"In Color (the Lamp Album)","uri":"http://58.222.38.160/amobile.music.tc.qq.com/F000001kl8h32gv5HN.flac?guid=930B11B52D8045C09D9BCF572C729CF0&vkey=E3419FA265BD365086697859CB3FE52C86B1EB43319B0502111C86CF7EB61559ECEE1806A72B08E334D986D5401CE874D549EFD3BCAE5ED9&uin=1152921504616111776&redirect=1&fromtag=101114","trackType":""}
Mar 30 10:49:28 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::syncState stateService pause
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::stPlaybackTimer
Mar 30 10:49:28 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:49:28 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:49:28 VTS volumio[23312]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85227,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"817 Kbps","isStreaming":false,"title":"Find Your Way","artist":"In Color","album":"In Color (the Lamp Album)","uri":"http://58.222.38.160/amobile.music.tc.qq.com/F000001kl8h32gv5HN.flac?guid=930B11B52D8045C09D9BCF572C729CF0&vkey=E3419FA265BD365086697859CB3FE52C86B1EB43319B0502111C86CF7EB61559ECEE1806A72B08E334D986D5401CE874D549EFD3BCAE5ED9&uin=1152921504616111776&redirect=1&fromtag=101114","trackType":""}
Mar 30 10:49:28 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::syncState stateService pause
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::stPlaybackTimer
Mar 30 10:49:28 VTS volumio[23312]: info: ------------------------------ 40ms
Mar 30 10:49:28 VTS volumio[23312]: info: ------------------------------ 39ms
Mar 30 10:49:28 VTS volumio[23312]: info: ------------------------------ 38ms
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:28 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:36 VTS nmbd[675]: [2024/03/30 10:49:36.525900, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Mar 30 10:49:36 VTS nmbd[675]: query_name_response: Multiple (2) responses received for a query on subnet 10.0.0.40 for name WORKGROUP<1d>.
Mar 30 10:49:36 VTS nmbd[675]: This response was from IP 10.0.0.2, reporting an IP address of 10.0.0.2.
Mar 30 10:49:51 VTS volumio[1648]: 93
Mar 30 10:49:51 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:51 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:51 VTS volumio[23312]: info:
Mar 30 10:49:51 VTS volumio[23312]: ---------------------------- Client requests Volume 93
Mar 30 10:49:51 VTS volumio[23312]: info: VolumeController::SetAlsaVolume93
Mar 30 10:49:51 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:51 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:51 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:51 VTS volumio[1648]: [158B blob data]
Mar 30 10:49:51 VTS volumio[1648]: {"time":1711766991621,"response":"volume Success"}93
Mar 30 10:49:51 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:51 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:51 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:52 VTS volumio[1648]: 87
Mar 30 10:49:52 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:52 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:52 VTS volumio[23312]: info:
Mar 30 10:49:52 VTS volumio[23312]: ---------------------------- Client requests Volume 87
Mar 30 10:49:52 VTS volumio[23312]: info: VolumeController::SetAlsaVolume87
Mar 30 10:49:52 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:52 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:52 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:52 VTS volumio[1648]: [158B blob data]
Mar 30 10:49:52 VTS volumio[1648]: {"time":1711766992681,"response":"volume Success"}87
Mar 30 10:49:52 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:52 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:52 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:53 VTS volumio[1648]: 81
Mar 30 10:49:53 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:53 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:53 VTS volumio[23312]: info:
Mar 30 10:49:53 VTS volumio[23312]: ---------------------------- Client requests Volume 81
Mar 30 10:49:53 VTS volumio[23312]: info: VolumeController::SetAlsaVolume81
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:53 VTS volumio[1648]: [158B blob data]
Mar 30 10:49:53 VTS volumio[1648]: {"time":1711766993165,"response":"volume Success"}81
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:53 VTS volumio[1648]: 75
Mar 30 10:49:53 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:53 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:53 VTS volumio[23312]: info:
Mar 30 10:49:53 VTS volumio[23312]: ---------------------------- Client requests Volume 75
Mar 30 10:49:53 VTS volumio[23312]: info: VolumeController::SetAlsaVolume75
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:53 VTS volumio[1648]: [158B blob data]
Mar 30 10:49:53 VTS volumio[1648]: {"time":1711766993242,"response":"volume Success"}75
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:53 VTS volumio[1648]: 68
Mar 30 10:49:53 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:53 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:53 VTS volumio[23312]: info:
Mar 30 10:49:53 VTS volumio[23312]: ---------------------------- Client requests Volume 68
Mar 30 10:49:53 VTS volumio[23312]: info: VolumeController::SetAlsaVolume68
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:53 VTS volumio[1648]: [158B blob data]
Mar 30 10:49:53 VTS volumio[1648]: {"time":1711766993492,"response":"volume Success"}68
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:53 VTS volumio[1648]: 62
Mar 30 10:49:53 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:53 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:53 VTS volumio[23312]: info:
Mar 30 10:49:53 VTS volumio[23312]: ---------------------------- Client requests Volume 62
Mar 30 10:49:53 VTS volumio[23312]: info: VolumeController::SetAlsaVolume62
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:53 VTS volumio[1648]: [158B blob data]
Mar 30 10:49:53 VTS volumio[1648]: {"time":1711766993777,"response":"volume Success"}62
Mar 30 10:49:53 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:53 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:54 VTS volumio[1648]: 56
Mar 30 10:49:54 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:54 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:54 VTS volumio[23312]: info:
Mar 30 10:49:54 VTS volumio[23312]: ---------------------------- Client requests Volume 56
Mar 30 10:49:54 VTS volumio[23312]: info: VolumeController::SetAlsaVolume56
Mar 30 10:49:54 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:54 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:54 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:54 VTS volumio[1648]: [158B blob data]
Mar 30 10:49:54 VTS volumio[1648]: {"time":1711766994077,"response":"volume Success"}56
Mar 30 10:49:54 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:54 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:54 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:54 VTS volumio[1648]: 50
Mar 30 10:49:54 VTS volumio[1648]: % Total % Received % Xferd Average Speed Time Time Time Current
Mar 30 10:49:54 VTS volumio[1648]: Dload Upload Total Spent Left Speed
Mar 30 10:49:54 VTS volumio[23312]: info:
Mar 30 10:49:54 VTS volumio[23312]: ---------------------------- Client requests Volume 50
Mar 30 10:49:54 VTS volumio[23312]: info: VolumeController::SetAlsaVolume50
Mar 30 10:49:54 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:49:54 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:49:54 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:49:54 VTS volumio[1648]: [237B blob data]
Mar 30 10:49:54 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:49:54 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:49:54 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:49:54 VTS volumio[1648]: {"time":1711766994406,"response":"volume Success"}50
Mar 30 10:50:09 VTS volumio[23312]: info: Clearing queue after UPNP request
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::ClearQueue
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::stop
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::stPlaybackTimer
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::updateTrackBlock
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrackBlock
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::serviceStop
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: ControllerMpd::stop
Mar 30 10:50:09 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand stop
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::clearPlayQueue
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::saveQueue
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushQueue
Mar 30 10:50:09 VTS volumio[23312]: info:
Mar 30 10:50:09 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:09 VTS volumio[23312]: info: sendMpdCommand stop took 20 milliseconds
Mar 30 10:50:09 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:09 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:09 VTS volumio[23312]: info:
Mar 30 10:50:09 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:09 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:09 VTS volumio[23312]: info: sendMpdCommand status took 6 milliseconds
Mar 30 10:50:09 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:09 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Mar 30 10:50:09 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::syncState stateService stop
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: No code
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: ------------------------------ 39ms
Mar 30 10:50:09 VTS volumio[23312]: info:
Mar 30 10:50:09 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:09 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:09 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:09 VTS volumio[23312]: info:
Mar 30 10:50:09 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:09 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:09 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:09 VTS volumio[23312]: error: updateQueue error: null
Mar 30 10:50:09 VTS volumio[23312]: info: ------------------------------ 44ms
Mar 30 10:50:09 VTS volumio[23312]: info: sendMpdCommand status took 4 milliseconds
Mar 30 10:50:09 VTS volumio[23312]: info: sendMpdCommand status took 3 milliseconds
Mar 30 10:50:09 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:09 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Mar 30 10:50:09 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::syncState stateService stop
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: No code
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Mar 30 10:50:09 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::syncState stateService stop
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: No code
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:09 VTS volumio[23312]: info: ------------------------------ 71ms
Mar 30 10:50:09 VTS volumio[23312]: info: ------------------------------ 68ms
Mar 30 10:50:09 VTS volumio[23312]: info:
Mar 30 10:50:09 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:09 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:09 VTS volumio[23312]: info:
Mar 30 10:50:09 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:09 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:09 VTS volumio[23312]: error: updateQueue error: null
Mar 30 10:50:09 VTS volumio[23312]: error: updateQueue error: null
Mar 30 10:50:09 VTS volumio[23312]: info: ------------------------------ 34ms
Mar 30 10:50:09 VTS volumio[23312]: info: ------------------------------ 33ms
Mar 30 10:50:09 VTS volumio[23312]: info: Starting UPNP Playback
Mar 30 10:50:09 VTS volumio[23312]: info: Preparing playback through UPNP
Mar 30 10:50:09 VTS volumio[23312]: info: CoreCommandRouter::volumioGetState
Mar 30 10:50:09 VTS volumio[23312]: info: CorePlayQueue::getTrack 0
Mar 30 10:50:09 VTS volumio[23312]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 3ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 2ms
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 3ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 2ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 1ms
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 3ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 2ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 1ms
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 3ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 2ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 1ms
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 3ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 3ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 2ms
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 2ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 1ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 2ms
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 4 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 3 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 2 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 8 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 5 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 4 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 3 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE).mp3","artist":null,"album":null,"uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus stop
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE).mp3","artist":null,"album":null,"uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE).mp3","artist":null,"album":null,"uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 34ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 77ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 76ms
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 66 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 65 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 66 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE).mp3","artist":null,"album":null,"uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE)","artist":"4 IN LOVE","album":"成名曲精选集 2010","uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE)","artist":"4 IN LOVE","album":"成名曲精选集 2010","uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 156ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 153ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 153ms
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces system playlist update
Mar 30 10:50:10 VTS volumio[23312]: info: Ignoring MPD Status Update
Mar 30 10:50:10 VTS volumio[23312]: info:
Mar 30 10:50:10 VTS volumio[23312]: ---------------------------- MPD announces state update: player
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::getState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand status
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 129ms
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 128 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 28ms
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 27 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 23ms
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand status took 21 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseState
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: verbose: ControllerMpd::parseTrackInfo
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE)","artist":"4 IN LOVE","album":"成名曲精选集 2010","uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE)","artist":"4 IN LOVE","album":"成名曲精选集 2010","uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ControllerMpd::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::servicePushState
Mar 30 10:50:10 VTS volumio[23312]: verbose: In UPNP mode
Mar 30 10:50:10 VTS volumio[23312]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"31 一千零一个愿望(4 IN LOVE)","artist":"4 IN LOVE","album":"成名曲精选集 2010","uri":"http://10.0.0.13:54156/.upnp/1.mp3","trackType":"mp3"}
Mar 30 10:50:10 VTS volumio[23312]: verbose: CURRENT POSITION 0
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState stateService play
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::syncState currentStatus play
Mar 30 10:50:10 VTS volumio[23312]: info: Received an update from plugin. extracting info from payload
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::pushState
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioPushState
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 184ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 82ms
Mar 30 10:50:10 VTS volumio[23312]: info: ------------------------------ 78ms
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreCommandRouter::volumioGetQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CoreStateMachine::getQueue
Mar 30 10:50:10 VTS volumio[23312]: info: CorePlayQueue::getQueue
Mar 30 10:50:12 VTS volumio[23312]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 30 10:50:12 VTS volumio[23312]: Error: connect ETIMEDOUT 199.59.149.203:443
Mar 30 10:50:12 VTS volumio[23312]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Mar 30 10:50:12 VTS volumio[23312]: errno: -110,
Mar 30 10:50:12 VTS volumio[23312]: code: 'ETIMEDOUT',
Mar 30 10:50:12 VTS volumio[23312]: syscall: 'connect',
Mar 30 10:50:12 VTS volumio[23312]: address: '199.59.149.203',
Mar 30 10:50:12 VTS volumio[23312]: port: 443
Mar 30 10:50:12 VTS volumio[23312]: }
Mar 30 10:50:12 VTS volumio[23312]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 30 10:50:13 VTS sudo[24622]: volumio : unable to resolve host VTS
Mar 30 10:50:13 VTS sudo[24622]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Mar 30 10:50:13 VTS sudo[24622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 10:49
Mar 30 10:50:13 VTS sudo[24622]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:15:21 AM CET"
VOLUMIO_VERSION="3.629"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="293a767fd1b71cabc5f5be4916f770a0"