-- Logs begin at Mon 2026-03-30 04:09:26 UTC, end at Tue 2026-04-14 04:18:55 UTC. --
Apr 14 04:17:12 opera volumio[10056]: info: Clearing queue after UPNP request
Apr 14 04:17:12 opera volumio[10056]: info: CoreStateMachine::ClearQueue
Apr 14 04:17:12 opera volumio[10056]: info: CoreStateMachine::stop
Apr 14 04:17:12 opera volumio[10056]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 14 04:17:12 opera volumio[10056]: verbose: UNSET VOLATILE
Apr 14 04:17:12 opera volumio[10056]: info: CoreStateMachine::stPlaybackTimer
Apr 14 04:17:12 opera volumio[10056]: info: CoreStateMachine::updateTrackBlock
Apr 14 04:17:12 opera volumio[10056]: info: CorePlayQueue::getTrackBlock
Apr 14 04:17:12 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:12 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:12 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:12 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:12 opera volumio[10056]: info: CoreStateMachine::serviceStop
Apr 14 04:17:12 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:12 opera volumio[10056]: info: ControllerMpd::stop
Apr 14 04:17:12 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand stop
Apr 14 04:17:12 opera volumio[10056]: info: CorePlayQueue::clearPlayQueue
Apr 14 04:17:12 opera volumio[10056]: info: CorePlayQueue::saveQueue
Apr 14 04:17:12 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:12 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:12 opera volumio[10056]: info: CoreCommandRouter::volumioPushQueue
Apr 14 04:17:12 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:12 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:12 opera volumio[10056]: info:
Apr 14 04:17:12 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:12 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:13 opera volumio[10056]: info:
Apr 14 04:17:13 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:13 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:13 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:13 opera volumio[10056]: info: sendMpdCommand stop took 57 milliseconds
Apr 14 04:17:13 opera volumio[10056]: info: Starting UPNP Playback
Apr 14 04:17:13 opera volumio[10056]: info: Preparing playback through UPNP
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::volumioGetState
Apr 14 04:17:13 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 14 04:17:13 opera volumio[10056]: error: updateQueue error: null
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 4ms
Apr 14 04:17:13 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 14 04:17:13 opera volumio[10056]: info: sendMpdCommand status took 5 milliseconds
Apr 14 04:17:13 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:13 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:13 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:13 opera volumio[10056]: 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}
Apr 14 04:17:13 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::syncState stateService stop
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus stop
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:13 opera volumio[10056]: info: No code
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 46ms
Apr 14 04:17:13 opera volumio[10056]: info: sendMpdCommand clearerror took 41 milliseconds
Apr 14 04:17:13 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:13 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:13 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:13 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:13 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:13 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:13 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:13 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:13 opera volumio[10056]: info:
Apr 14 04:17:13 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:13 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:13 opera volumio[10056]: info:
Apr 14 04:17:13 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:13 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 2ms
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:13 opera volumio[10056]: info:
Apr 14 04:17:13 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:13 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:13 opera volumio[10056]: info:
Apr 14 04:17:13 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:13 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:13 opera volumio[10056]: info:
Apr 14 04:17:13 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:13 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:13 opera volumio[10056]: info:
Apr 14 04:17:13 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:13 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:13 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:23 opera volumio[10056]: info:
Apr 14 04:17:23 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:23 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:23 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:23 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 14 04:17:23 opera volumio[10056]: info: sendMpdCommand status took 3 milliseconds
Apr 14 04:17:23 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:23 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 14 04:17:23 opera volumio[10056]: info: sendMpdCommand clearerror took 3 milliseconds
Apr 14 04:17:23 opera volumio[10056]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 14 04:17:23 opera volumio[10056]: verbose: ControllerMpd::parseTrackInfo
Apr 14 04:17:23 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:23 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:23 opera volumio[10056]: 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":"Something in Water","artist":"Men I Trust","album":"Oncle Jazz","uri":"http://m8.music.126.net/20260414124212/a6885d52c9d1e32f6552d0d7cd81f3d0/ymusic/obj/w5zDlMODwrDDiGjCn8Ky/30745034071/3a66/67d0/2b02/2ce52a92ada923278feb0b124aa2d45e.flac?vuutv=RLiKEnsZRVtlgZ607YNxz9HvcrP9wmLrag0aD8UQwPeTesfr5MbHjS9KsjFTjjjeImSvmITYPN1uIbyR0XIOrYVVUznEJ7tde0hXVAuHc+4=&dlna=1","trackType":""}
Apr 14 04:17:23 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::syncState stateService stop
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus stop
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:23 opera volumio[10056]: info: No code
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:23 opera volumio[10056]: info: ------------------------------ 20ms
Apr 14 04:17:23 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:23 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:23 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:23 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:23 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:23 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:23 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:23 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:34 opera volumio[10056]: info:
Apr 14 04:17:34 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:34 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:34 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:34 opera volumio[10056]: info: sendMpdCommand status took 2 milliseconds
Apr 14 04:17:34 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:34 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 14 04:17:34 opera volumio[10056]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 14 04:17:34 opera volumio[10056]: verbose: ControllerMpd::parseTrackInfo
Apr 14 04:17:34 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:34 opera volumio[10056]: verbose: In UPNP mode
Apr 14 04:17:34 opera volumio[10056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Something in Water","artist":"Men I Trust","album":"Oncle Jazz","uri":"http://m8.music.126.net/20260414124212/a6885d52c9d1e32f6552d0d7cd81f3d0/ymusic/obj/w5zDlMODwrDDiGjCn8Ky/30745034071/3a66/67d0/2b02/2ce52a92ada923278feb0b124aa2d45e.flac?vuutv=RLiKEnsZRVtlgZ607YNxz9HvcrP9wmLrag0aD8UQwPeTesfr5MbHjS9KsjFTjjjeImSvmITYPN1uIbyR0XIOrYVVUznEJ7tde0hXVAuHc+4=&dlna=1","trackType":""}
Apr 14 04:17:34 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::syncState stateService play
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus stop
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:34 opera volumio[10056]: info: ------------------------------ 14ms
Apr 14 04:17:34 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:34 opera volumio[10056]: info: Clearing queue after UPNP request
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::ClearQueue
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::stop
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 14 04:17:34 opera volumio[10056]: verbose: UNSET VOLATILE
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::stPlaybackTimer
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::updateTrackBlock
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrackBlock
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::serviceStop
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:34 opera volumio[10056]: info: ControllerMpd::stop
Apr 14 04:17:34 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand stop
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::clearPlayQueue
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::saveQueue
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioPushQueue
Apr 14 04:17:34 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:34 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:34 opera volumio[10056]: info:
Apr 14 04:17:34 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:34 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:34 opera volumio[10056]: info:
Apr 14 04:17:34 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:34 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:34 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:34 opera volumio[10056]: info: sendMpdCommand stop took 22 milliseconds
Apr 14 04:17:34 opera volumio[10056]: error: updateQueue error: null
Apr 14 04:17:34 opera volumio[10056]: info: ------------------------------ 4ms
Apr 14 04:17:34 opera volumio[10056]: info: sendMpdCommand status took 2 milliseconds
Apr 14 04:17:34 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:34 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:34 opera volumio[10056]: 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}
Apr 14 04:17:34 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::syncState stateService stop
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus stop
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:34 opera volumio[10056]: info: No code
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:34 opera volumio[10056]: info: ------------------------------ 19ms
Apr 14 04:17:34 opera volumio[10056]: info: Starting UPNP Playback
Apr 14 04:17:34 opera volumio[10056]: info: Preparing playback through UPNP
Apr 14 04:17:34 opera volumio[10056]: info: CoreCommandRouter::volumioGetState
Apr 14 04:17:34 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:34 opera volumio[10056]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 14 04:17:34 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:34 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:34 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:35 opera volumio[10056]: info:
Apr 14 04:17:35 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:35 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:35 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:35 opera volumio[10056]: info:
Apr 14 04:17:35 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:35 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:35 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:35 opera volumio[10056]: info:
Apr 14 04:17:35 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:35 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:35 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:35 opera volumio[10056]: info:
Apr 14 04:17:35 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:35 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:35 opera volumio[10056]: info: ------------------------------ 2ms
Apr 14 04:17:35 opera volumio[10056]: info:
Apr 14 04:17:35 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:35 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:35 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:35 opera volumio[10056]: info:
Apr 14 04:17:35 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:35 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:35 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:36 opera volumio[10056]: info:
Apr 14 04:17:36 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:36 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:36 opera volumio[10056]: info:
Apr 14 04:17:36 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:36 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:36 opera volumio[10056]: info: sendMpdCommand status took 2 milliseconds
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 14 04:17:36 opera volumio[10056]: info: sendMpdCommand status took 2 milliseconds
Apr 14 04:17:36 opera volumio[10056]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::parseTrackInfo
Apr 14 04:17:36 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:36 opera volumio[10056]: verbose: In UPNP mode
Apr 14 04:17:36 opera volumio[10056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":506,"duration":284,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4713 Kbps","isStreaming":false,"title":"Is This Love","artist":"Whitesnake","album":"Whitesnake","uri":"http://m8.music.126.net/20260414124234/a5b582cffc9b2b4f6e0a9c3a4c766605/ymusic/obj/w5zDlMODwrDDiGjCn8Ky/30003639763/84d9/de3c/cdbd/d46559c2bc4f31e9417c08c593ac64fd.flac?vuutv=Gwbbpg78HzZgyyOFJaUhecE3Ta5cVzjwwsyLgDOCTbQHb9PKR/Q5y1tYYTuKBw3dHdy2lVKc6QyxNQR8WVd4xoMORtOuioH1blcn28ycLVY=&dlna=1","trackType":""}
Apr 14 04:17:36 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::syncState stateService play
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus stop
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:36 opera volumio[10056]: info: ------------------------------ 45ms
Apr 14 04:17:36 opera volumio[10056]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 14 04:17:36 opera volumio[10056]: verbose: ControllerMpd::parseTrackInfo
Apr 14 04:17:36 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:36 opera volumio[10056]: verbose: In UPNP mode
Apr 14 04:17:36 opera volumio[10056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":506,"duration":284,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4713 Kbps","isStreaming":false,"title":"Is This Love","artist":"Whitesnake","album":"Whitesnake","uri":"http://m8.music.126.net/20260414124234/a5b582cffc9b2b4f6e0a9c3a4c766605/ymusic/obj/w5zDlMODwrDDiGjCn8Ky/30003639763/84d9/de3c/cdbd/d46559c2bc4f31e9417c08c593ac64fd.flac?vuutv=Gwbbpg78HzZgyyOFJaUhecE3Ta5cVzjwwsyLgDOCTbQHb9PKR/Q5y1tYYTuKBw3dHdy2lVKc6QyxNQR8WVd4xoMORtOuioH1blcn28ycLVY=&dlna=1","trackType":""}
Apr 14 04:17:36 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::syncState stateService play
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus play
Apr 14 04:17:36 opera volumio[10056]: info: Received an update from plugin. extracting info from payload
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:36 opera volumio[10056]: info: ------------------------------ 27ms
Apr 14 04:17:36 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:36 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:36 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:36 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:36 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:36 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:36 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:36 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:39 opera volumio[10056]: info:
Apr 14 04:17:39 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:39 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:39 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:39 opera volumio[10056]: info: sendMpdCommand status took 6 milliseconds
Apr 14 04:17:39 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:39 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 14 04:17:39 opera volumio[10056]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 14 04:17:39 opera volumio[10056]: verbose: ControllerMpd::parseTrackInfo
Apr 14 04:17:39 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:39 opera volumio[10056]: verbose: In UPNP mode
Apr 14 04:17:39 opera volumio[10056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":284,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4789 Kbps","isStreaming":false,"title":"Is This Love","artist":"Whitesnake","album":"Whitesnake","uri":"http://m8.music.126.net/20260414124234/a5b582cffc9b2b4f6e0a9c3a4c766605/ymusic/obj/w5zDlMODwrDDiGjCn8Ky/30003639763/84d9/de3c/cdbd/d46559c2bc4f31e9417c08c593ac64fd.flac?vuutv=Gwbbpg78HzZgyyOFJaUhecE3Ta5cVzjwwsyLgDOCTbQHb9PKR/Q5y1tYYTuKBw3dHdy2lVKc6QyxNQR8WVd4xoMORtOuioH1blcn28ycLVY=&dlna=1","trackType":""}
Apr 14 04:17:39 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:39 opera volumio[10056]: info: CoreStateMachine::syncState stateService play
Apr 14 04:17:39 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus play
Apr 14 04:17:39 opera volumio[10056]: info: Received an update from plugin. extracting info from payload
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 14 04:17:39 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:39 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:39 opera volumio[10056]: info: ------------------------------ 21ms
Apr 14 04:17:39 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:39 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:39 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:39 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:39 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:39 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:39 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:40 opera volumio[10056]: info: Clearing queue after UPNP request
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::ClearQueue
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::stop
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 14 04:17:40 opera volumio[10056]: verbose: UNSET VOLATILE
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::stPlaybackTimer
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::updateTrackBlock
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrackBlock
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::serviceStop
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:40 opera volumio[10056]: info: ControllerMpd::stop
Apr 14 04:17:40 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand stop
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::clearPlayQueue
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::saveQueue
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::volumioPushQueue
Apr 14 04:17:40 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:40 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:40 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:40 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:40 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:40 opera volumio[10056]: info: sendMpdCommand stop took 32 milliseconds
Apr 14 04:17:40 opera volumio[10056]: error: updateQueue error: null
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 6ms
Apr 14 04:17:40 opera volumio[10056]: info: sendMpdCommand status took 5 milliseconds
Apr 14 04:17:40 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:40 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:40 opera volumio[10056]: 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}
Apr 14 04:17:40 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::syncState stateService stop
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus stop
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:40 opera volumio[10056]: info: No code
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 23ms
Apr 14 04:17:40 opera volumio[10056]: info: Starting UPNP Playback
Apr 14 04:17:40 opera volumio[10056]: info: Preparing playback through UPNP
Apr 14 04:17:40 opera volumio[10056]: info: CoreCommandRouter::volumioGetState
Apr 14 04:17:40 opera volumio[10056]: info: CorePlayQueue::getTrack 0
Apr 14 04:17:40 opera volumio[10056]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 14 04:17:40 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:40 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:40 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:40 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 5ms
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:40 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:40 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:40 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 2ms
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:40 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 1ms
Apr 14 04:17:40 opera volumio[10056]: info:
Apr 14 04:17:40 opera volumio[10056]: ---------------------------- MPD announces system playlist update
Apr 14 04:17:40 opera volumio[10056]: info: Ignoring MPD Status Update
Apr 14 04:17:40 opera volumio[10056]: info: ------------------------------ 9ms
Apr 14 04:17:41 opera volumio[10056]: info:
Apr 14 04:17:41 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:41 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:41 opera volumio[10056]: info:
Apr 14 04:17:41 opera volumio[10056]: ---------------------------- MPD announces state update: player
Apr 14 04:17:41 opera volumio[10056]: info: sendMpdCommand status took 35 milliseconds
Apr 14 04:17:41 opera volumio[10056]: info: ControllerMpd::getState
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand status
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 14 04:17:41 opera volumio[10056]: info: sendMpdCommand status took 2 milliseconds
Apr 14 04:17:41 opera volumio[10056]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::parseState
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::parseTrackInfo
Apr 14 04:17:41 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:41 opera volumio[10056]: verbose: In UPNP mode
Apr 14 04:17:41 opera volumio[10056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Something in Water","artist":"Men I Trust","album":"Oncle Jazz","uri":"http://m8.music.126.net/20260414124239/338a0df8f67c49871a42dd66620eca37/ymusic/obj/w5zDlMODwrDDiGjCn8Ky/30745034071/3a66/67d0/2b02/2ce52a92ada923278feb0b124aa2d45e.flac?vuutv=APDkZyclziLXys+2HLvbWPAgX/qb+2l+HyDI8Vmw5ikqc5PL6X7CZIhItB/+EIkeSHDm+YxLAtenDGe5G6S74HtwCUdjhTWVDtBHfPf58PY=&dlna=1","trackType":""}
Apr 14 04:17:41 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::syncState stateService play
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus stop
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:41 opera volumio[10056]: info: ------------------------------ 46ms
Apr 14 04:17:41 opera volumio[10056]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 14 04:17:41 opera volumio[10056]: verbose: ControllerMpd::parseTrackInfo
Apr 14 04:17:41 opera volumio[10056]: info: ControllerMpd::pushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::servicePushState
Apr 14 04:17:41 opera volumio[10056]: verbose: In UPNP mode
Apr 14 04:17:41 opera volumio[10056]: verbose: STATE SERVICE {"status":"play","position":0,"seek":506,"duration":199,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4902 Kbps","isStreaming":false,"title":"Something in Water","artist":"Men I Trust","album":"Oncle Jazz","uri":"http://m8.music.126.net/20260414124239/338a0df8f67c49871a42dd66620eca37/ymusic/obj/w5zDlMODwrDDiGjCn8Ky/30745034071/3a66/67d0/2b02/2ce52a92ada923278feb0b124aa2d45e.flac?vuutv=APDkZyclziLXys+2HLvbWPAgX/qb+2l+HyDI8Vmw5ikqc5PL6X7CZIhItB/+EIkeSHDm+YxLAtenDGe5G6S74HtwCUdjhTWVDtBHfPf58PY=&dlna=1","trackType":""}
Apr 14 04:17:41 opera volumio[10056]: verbose: CURRENT POSITION 0
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::syncState stateService play
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::syncState currentStatus play
Apr 14 04:17:41 opera volumio[10056]: info: Received an update from plugin. extracting info from payload
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::pushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::volumioPushState
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 14 04:17:41 opera volumio[10056]: info: ------------------------------ 22ms
Apr 14 04:17:41 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:41 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:41 opera volumio[10056]: info: Updating RAAT Signal Path
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:41 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:41 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:41 opera volumio[10056]: info: CoreCommandRouter::volumioGetQueue
Apr 14 04:17:41 opera volumio[10056]: info: CoreStateMachine::getQueue
Apr 14 04:17:41 opera volumio[10056]: info: CorePlayQueue::getQueue
Apr 14 04:17:41 opera volumio[10056]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Whitesnake/Whitesnake/e0293144-e069-4e8b-bda5-5301f3fa4ea5.jpg'
Apr 14 04:18:55 opera volumio[10056]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 14 04:18:55 opera volumio[10056]: { Error: connect ETIMEDOUT 128.242.250.157:443
Apr 14 04:18:55 opera volumio[10056]: at Object._errnoException (util.js:1022:11)
Apr 14 04:18:55 opera volumio[10056]: at _exceptionWithHostPort (util.js:1044:20)
Apr 14 04:18:55 opera volumio[10056]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Apr 14 04:18:55 opera volumio[10056]: code: 'ETIMEDOUT',
Apr 14 04:18:55 opera volumio[10056]: errno: 'ETIMEDOUT',
Apr 14 04:18:55 opera volumio[10056]: syscall: 'connect',
Apr 14 04:18:55 opera volumio[10056]: address: '128.242.250.157',
Apr 14 04:18:55 opera volumio[10056]: port: 443 }
Apr 14 04:18:55 opera volumio[10056]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 14 04:18:55 opera sudo[12421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-14 04:17
Apr 14 04:18:55 opera sudo[12421]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="opera"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022"
VOLUMIO_VERSION="1.033"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_VENDOR="Opera Consonance"
VOLUMIO_MODEL="X5"
VOLUMIO_VENDOR_MODEL="Opera X5"
VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"