-- Logs begin at Sat 2024-04-20 07:01:37 UTC, end at Sun 2024-04-21 12:45:23 UTC. --
Apr 21 12:44:05 musical-fidelity volumio[12398]: info:
Apr 21 12:44:05 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: sendMpdCommand status took 3 milliseconds
Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:05 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: ------------------------------ 29ms
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:05 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::stop
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: error: updateQueue error: null
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Starting UPNP Playback
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Preparing playback through UPNP
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: sendMpdCommand status took 8 milliseconds
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:06 musical-fidelity volumio[12398]: info:
Apr 21 12:44:06 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800002rkevY0Wf4ob.mp3?guid=00000000411549570000018c24bfe7bf&vkey=845B9B34B201C6EBC7543320A53220BA12CC1B35196A37C047E8E511BCA6891D13B5522E389EE4A8C78192B22A24721E4D2C869A2B0BEEDD&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 28ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: ------------------------------ 20ms
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: sendMpdCommand status took 18 milliseconds
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:06 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:06 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 14 milliseconds
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800002rkevY0Wf4ob.mp3?guid=00000000411549570000018c24bfe7bf&vkey=845B9B34B201C6EBC7543320A53220BA12CC1B35196A37C047E8E511BCA6891D13B5522E389EE4A8C78192B22A24721E4D2C869A2B0BEEDD&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ------------------------------ 66ms
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:07 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/NewJeans/NewJeans%20%27Super%20Shy%27/5b9ba58a-d02e-4bda-88ae-9c82311efb42.jpg'
Apr 21 12:44:07 musical-fidelity volumio[12398]: info:
Apr 21 12:44:07 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: sendMpdCommand status took 3 milliseconds
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"罗刹海市","artist":"刀郎","album":"山歌寥哉","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800002rkevY0Wf4ob.mp3?guid=00000000411549570000018c24bfe7bf&vkey=845B9B34B201C6EBC7543320A53220BA12CC1B35196A37C047E8E511BCA6891D13B5522E389EE4A8C78192B22A24721E4D2C869A2B0BEEDD&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ------------------------------ 26ms
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::stop
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:07 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:07 musical-fidelity volumio[12398]: info:
Apr 21 12:44:07 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:07 musical-fidelity volumio[12398]: error: updateQueue error: null
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Starting UPNP Playback
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: Preparing playback through UPNP
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:07 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand status took 10 milliseconds
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 14ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand status took 12 milliseconds
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":109,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 62ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 36 milliseconds
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":109,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 85ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:08 musical-fidelity volumio[12398]: info:
Apr 21 12:44:08 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand status took 5 milliseconds
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"New Jeans","artist":"NewJeans","album":"NewJeans 'Super Shy'","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M800001QG6Rf3o63hU.mp3?guid=00000000411549570000018c24bfe7bf&vkey=84C2F5781DE44F02EEB71983837023FCF3E0EF9B0E3CF46B204385A656A56352D467E8C470D6A2AC53F4D7DEA69B4EEEE5BE1E6A46DC3EAF&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: ------------------------------ 53ms
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:08 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/NewJeans/NewJeans%20%27Super%20Shy%27/5b9ba58a-d02e-4bda-88ae-9c82311efb42.jpg'
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::stop
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:08 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue
Apr 21 12:44:08 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Starting UPNP Playback
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Preparing playback through UPNP
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 21 12:44:09 musical-fidelity volumio[12398]: error: updateQueue error: null
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 4ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: sendMpdCommand status took 11 milliseconds
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:09 musical-fidelity volumio[12398]: info:
Apr 21 12:44:09 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: sendMpdCommand status took 5 milliseconds
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ------------------------------ 4ms
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"TOP","artist":"Stray Kids","album":"TOP","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M80000233xML43Ubsa.mp3?guid=00000000411549570000018c24bfe7bf&vkey=977E55760F55E74BEFA01015D26AEACE6AB6C83EE22E94C82119B35EB7D0E7DFCC10EC1A5A9807E0C0540956ABD3CCCF5743D766D6E59338&uin=2855958070&src=M800000mM5rr4QiAwS.mp3&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:09 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:09 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: ------------------------------ 38ms
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 16 milliseconds
Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"TOP","artist":"Stray Kids","album":"TOP","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M80000233xML43Ubsa.mp3?guid=00000000411549570000018c24bfe7bf&vkey=977E55760F55E74BEFA01015D26AEACE6AB6C83EE22E94C82119B35EB7D0E7DFCC10EC1A5A9807E0C0540956ABD3CCCF5743D766D6E59338&uin=2855958070&src=M800000mM5rr4QiAwS.mp3&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:10 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: ------------------------------ 65ms
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:10 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:10 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/NewJeans/NewJeans%20%27Super%20Shy%27/5b9ba58a-d02e-4bda-88ae-9c82311efb42.jpg'
Apr 21 12:44:31 musical-fidelity volumio[12398]: info:
Apr 21 12:44:31 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: sendMpdCommand status took 1 milliseconds
Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"TOP","artist":"Stray Kids","album":"TOP","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M80000233xML43Ubsa.mp3?guid=00000000411549570000018c24bfe7bf&vkey=977E55760F55E74BEFA01015D26AEACE6AB6C83EE22E94C82119B35EB7D0E7DFCC10EC1A5A9807E0C0540956ABD3CCCF5743D766D6E59338&uin=2855958070&src=M800000mM5rr4QiAwS.mp3&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:31 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService stop
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::play index undefined
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: ------------------------------ 31ms
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:31 musical-fidelity volumio[12398]: info: Clearing queue after UPNP request
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::ClearQueue
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::stop
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: UNSET VOLATILE
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CorePlayQueue::clearPlayQueue
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CorePlayQueue::saveQueue
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushQueue
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: error: updateQueue error: null
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Starting UPNP Playback
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Preparing playback through UPNP
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioGetState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CorePlayQueue::getTrack 0
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 3ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 4ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 4ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 4ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 2ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces state update: player
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand status took 19 milliseconds
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::getState
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: info:
Apr 21 12:44:32 musical-fidelity volumio[12398]: ---------------------------- MPD announces system playlist update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Ignoring MPD Status Update
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand status took 5 milliseconds
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseState
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"烟雨唱扬州","artist":"李殊","album":"影视金曲·感动的心","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M8000030i9qm32V1qd.mp3?guid=00000000411549570000018c24bfe7bf&vkey=4B22306105CBF3AB74A0963D7AAE12A87670ED03788A075FA81C8E2BEAF08873BA08FBF8CB0B2CD7D9A954F9A5266338888094574BCCA8C2&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus stop
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 42ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 21ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: ControllerMpd::parseTrackInfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ControllerMpd::pushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::servicePushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: In UPNP mode
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":167,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"烟雨唱扬州","artist":"李殊","album":"影视金曲·感动的心","uri":"http://117.34.49.49/amobile.music.tc.qq.com/M8000030i9qm32V1qd.mp3?guid=00000000411549570000018c24bfe7bf&vkey=4B22306105CBF3AB74A0963D7AAE12A87670ED03788A075FA81C8E2BEAF08873BA08FBF8CB0B2CD7D9A954F9A5266338888094574BCCA8C2&uin=2855958070&redirect=1&fromtag=111093","trackType":""}
Apr 21 12:44:32 musical-fidelity volumio[12398]: verbose: CURRENT POSITION 0
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState stateService play
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::syncState currentStatus play
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Received an update from plugin. extracting info from payload
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreStateMachine::pushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::volumioPushState
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: ------------------------------ 66ms
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:32 musical-fidelity volumio[12398]: info: Updating RAAT Signal Path
Apr 21 12:44:33 musical-fidelity volumio[12398]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Stray%20Kids/TOP/12978877-8957-4d96-88d3-9d0dedd4ba5b.jpg'
Apr 21 12:45:22 musical-fidelity volumio[12398]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 12:45:22 musical-fidelity volumio[12398]: { Error: connect ETIMEDOUT 128.242.240.221:443
Apr 21 12:45:22 musical-fidelity volumio[12398]: at Object._errnoException (util.js:1022:11)
Apr 21 12:45:22 musical-fidelity volumio[12398]: at _exceptionWithHostPort (util.js:1044:20)
Apr 21 12:45:22 musical-fidelity volumio[12398]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Apr 21 12:45:22 musical-fidelity volumio[12398]: code: 'ETIMEDOUT',
Apr 21 12:45:22 musical-fidelity volumio[12398]: errno: 'ETIMEDOUT',
Apr 21 12:45:22 musical-fidelity volumio[12398]: syscall: 'connect',
Apr 21 12:45:22 musical-fidelity volumio[12398]: address: '128.242.240.221',
Apr 21 12:45:22 musical-fidelity volumio[12398]: port: 443 }
Apr 21 12:45:22 musical-fidelity volumio[12398]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 12:45:23 musical-fidelity sudo[15009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 12:44
Apr 21 12:45:23 musical-fidelity sudo[15009]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="mf"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022"
VOLUMIO_VERSION="1.079"
VOLUMIO_HARDWARE="pi"
VOLUMIO_VENDOR="Musical Fidelity"
VOLUMIO_MODEL="MX-Stream"
VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream"
VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"