-- Logs begin at Wed 2021-12-01 13:09:13 UTC, end at Tue 2024-07-09 13:41:23 UTC. --
Jul 09 13:40:05 opera volumio[1130]: info:
Jul 09 13:40:05 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:05 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:05 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:05 opera volumio[1130]: info: sendMpdCommand status took 1 milliseconds
Jul 09 13:40:05 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:05 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:05 opera volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 09 13:40:05 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:05 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:05 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:05 opera volumio[1130]: 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":"Melody of Heartbeat","artist":"Artem Uzunov","album":"Let`S Do It","uri":"http://aqqmusic.tc.qq.com/F000000ab0lM4HISmE.flac?guid=ffffffffb2377c98000001903a3bdd8f&vkey=8C536C0DD07C766BB0CCDBE8A7762F1595BE537A7AE8D5F7828BBB2653B8AD0B766EF40DED81466A0535922A027E4B44917F8696D414413D&uin=1152921504950983260&src=F000003ZUii01yW1xm.flac&redirect=1&fromtag=111114","trackType":""}
Jul 09 13:40:05 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::syncState stateService stop
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::play index undefined
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:05 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:05 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:05 opera volumio[1130]: info: ------------------------------ 19ms
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:05 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:05 opera volumio[1130]: info: Clearing queue after UPNP request
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::ClearQueue
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::stop
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 13:40:05 opera volumio[1130]: verbose: UNSET VOLATILE
Jul 09 13:40:05 opera volumio[1130]: info: CorePlayQueue::clearPlayQueue
Jul 09 13:40:05 opera volumio[1130]: info: CorePlayQueue::saveQueue
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::volumioPushQueue
Jul 09 13:40:05 opera volumio[1130]: info:
Jul 09 13:40:05 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:05 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:05 opera volumio[1130]: error: updateQueue error: null
Jul 09 13:40:05 opera volumio[1130]: info: ------------------------------ 2ms
Jul 09 13:40:05 opera volumio[1130]: info: Starting UPNP Playback
Jul 09 13:40:05 opera volumio[1130]: info: Preparing playback through UPNP
Jul 09 13:40:05 opera volumio[1130]: info: CoreCommandRouter::volumioGetState
Jul 09 13:40:05 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:05 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 09 13:40:06 opera volumio[1130]: info:
Jul 09 13:40:06 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:06 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:06 opera volumio[1130]: info:
Jul 09 13:40:06 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:06 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:06 opera volumio[1130]: info: ------------------------------ 2ms
Jul 09 13:40:06 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:06 opera volumio[1130]: info:
Jul 09 13:40:06 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:06 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:06 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:06 opera volumio[1130]: info:
Jul 09 13:40:06 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:06 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:06 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:06 opera volumio[1130]: info:
Jul 09 13:40:06 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:06 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:06 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:06 opera volumio[1130]: info:
Jul 09 13:40:06 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:06 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:06 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:07 opera volumio[1130]: info:
Jul 09 13:40:07 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:07 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:07 opera volumio[1130]: info: sendMpdCommand status took 1 milliseconds
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:07 opera volumio[1130]: info:
Jul 09 13:40:07 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:07 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:07 opera volumio[1130]: info:
Jul 09 13:40:07 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:07 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:07 opera volumio[1130]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:07 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:07 opera volumio[1130]: verbose: In UPNP mode
Jul 09 13:40:07 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":397,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hurts Like Love","artist":"Costa Mee","album":"Hurts Like Love","uri":"http://aqqmusic.tc.qq.com/M5000013tDJI1fPXKA.mp3?guid=ffffffffb2377c98000001903a3bdd8f&vkey=1AF5CA262A1556DA3E34A9C3E9D79E920047631E61DC19580CD8C560D469771916392F5A7011C5836E44EFF51275E04829C4DA3502D355EB&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""}
Jul 09 13:40:07 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::syncState stateService play
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus stop
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:07 opera volumio[1130]: info: ------------------------------ 16ms
Jul 09 13:40:07 opera volumio[1130]: info: ------------------------------ 12ms
Jul 09 13:40:07 opera volumio[1130]: info: sendMpdCommand status took 12 milliseconds
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:07 opera volumio[1130]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 09 13:40:07 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:07 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:07 opera volumio[1130]: verbose: In UPNP mode
Jul 09 13:40:07 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":397,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Hurts Like Love","artist":"Costa Mee","album":"Hurts Like Love","uri":"http://aqqmusic.tc.qq.com/M5000013tDJI1fPXKA.mp3?guid=ffffffffb2377c98000001903a3bdd8f&vkey=1AF5CA262A1556DA3E34A9C3E9D79E920047631E61DC19580CD8C560D469771916392F5A7011C5836E44EFF51275E04829C4DA3502D355EB&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""}
Jul 09 13:40:07 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::syncState stateService play
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play
Jul 09 13:40:07 opera volumio[1130]: info: Received an update from plugin. extracting info from payload
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:07 opera volumio[1130]: info: ------------------------------ 39ms
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:07 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:07 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:07 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:07 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:07 opera volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Artem%20Uzunov/Let%60S%20Do%20It/f0fac77e-17c0-4d6b-bfa4-7d0b28aabe5a.jpg'
Jul 09 13:40:43 opera volumio[1130]: info:
Jul 09 13:40:43 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:43 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:43 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:43 opera volumio[1130]: info: sendMpdCommand status took 1 milliseconds
Jul 09 13:40:43 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:43 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:43 opera volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 09 13:40:43 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:43 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:43 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:43 opera volumio[1130]: 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":"Hurts Like Love","artist":"Costa Mee","album":"Hurts Like Love","uri":"http://aqqmusic.tc.qq.com/M5000013tDJI1fPXKA.mp3?guid=ffffffffb2377c98000001903a3bdd8f&vkey=1AF5CA262A1556DA3E34A9C3E9D79E920047631E61DC19580CD8C560D469771916392F5A7011C5836E44EFF51275E04829C4DA3502D355EB&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""}
Jul 09 13:40:43 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::syncState stateService stop
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::play index undefined
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:43 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:43 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:43 opera volumio[1130]: info: ------------------------------ 16ms
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:43 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:43 opera volumio[1130]: info: Clearing queue after UPNP request
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::ClearQueue
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::stop
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 13:40:43 opera volumio[1130]: verbose: UNSET VOLATILE
Jul 09 13:40:43 opera volumio[1130]: info: CorePlayQueue::clearPlayQueue
Jul 09 13:40:43 opera volumio[1130]: info: CorePlayQueue::saveQueue
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::volumioPushQueue
Jul 09 13:40:43 opera volumio[1130]: info:
Jul 09 13:40:43 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:43 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:43 opera volumio[1130]: error: updateQueue error: null
Jul 09 13:40:43 opera volumio[1130]: info: ------------------------------ 4ms
Jul 09 13:40:43 opera volumio[1130]: info: Starting UPNP Playback
Jul 09 13:40:43 opera volumio[1130]: info: Preparing playback through UPNP
Jul 09 13:40:43 opera volumio[1130]: info: CoreCommandRouter::volumioGetState
Jul 09 13:40:43 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:43 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:44 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:44 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 4ms
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 2ms
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:44 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:44 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 2ms
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:44 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:44 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:44 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:44 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:44 opera volumio[1130]: info:
Jul 09 13:40:44 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:44 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:44 opera volumio[1130]: info: sendMpdCommand status took 3 milliseconds
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 5ms
Jul 09 13:40:44 opera volumio[1130]: info: sendMpdCommand status took 4 milliseconds
Jul 09 13:40:44 opera volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:44 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:44 opera volumio[1130]: verbose: In UPNP mode
Jul 09 13:40:44 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GOOD-BYE青春","artist":"長渕剛","album":"Tsuyoshi Nagabuchi All Time Best 2014 傷つき打ちのめされても、長渕剛。","uri":"http://aqqmusic.tc.qq.com/M500000z8wyQ4APHlI.mp3?guid=ffffffffb2377c98000001903a3bdd8f&vkey=5CFCA33C649765D9F150162F01C62652EA5443F949C052A71AB45A6C59D743FD08D33D31A47F237FD90FE99CB8D4BDF44524C65B0D059380&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""}
Jul 09 13:40:44 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::syncState stateService play
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus stop
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 25ms
Jul 09 13:40:44 opera volumio[1130]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jul 09 13:40:44 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:44 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:44 opera volumio[1130]: verbose: In UPNP mode
Jul 09 13:40:44 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"GOOD-BYE青春","artist":"長渕剛","album":"Tsuyoshi Nagabuchi All Time Best 2014 傷つき打ちのめされても、長渕剛。","uri":"http://aqqmusic.tc.qq.com/M500000z8wyQ4APHlI.mp3?guid=ffffffffb2377c98000001903a3bdd8f&vkey=5CFCA33C649765D9F150162F01C62652EA5443F949C052A71AB45A6C59D743FD08D33D31A47F237FD90FE99CB8D4BDF44524C65B0D059380&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""}
Jul 09 13:40:44 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::syncState stateService play
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play
Jul 09 13:40:44 opera volumio[1130]: info: Received an update from plugin. extracting info from payload
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:44 opera volumio[1130]: info: ------------------------------ 47ms
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:44 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:44 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:44 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:44 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:49 opera volumio[1130]: info:
Jul 09 13:40:49 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:49 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:49 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:49 opera volumio[1130]: info: sendMpdCommand status took 0 milliseconds
Jul 09 13:40:49 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:49 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:49 opera volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 09 13:40:49 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:49 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:49 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:49 opera volumio[1130]: 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":"GOOD-BYE青春","artist":"長渕剛","album":"Tsuyoshi Nagabuchi All Time Best 2014 傷つき打ちのめされても、長渕剛。","uri":"http://aqqmusic.tc.qq.com/M500000z8wyQ4APHlI.mp3?guid=ffffffffb2377c98000001903a3bdd8f&vkey=5CFCA33C649765D9F150162F01C62652EA5443F949C052A71AB45A6C59D743FD08D33D31A47F237FD90FE99CB8D4BDF44524C65B0D059380&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""}
Jul 09 13:40:49 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::syncState stateService stop
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::play index undefined
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:49 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:49 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:49 opera volumio[1130]: info: ------------------------------ 14ms
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:49 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:49 opera volumio[1130]: info: Clearing queue after UPNP request
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::ClearQueue
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::stop
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 13:40:49 opera volumio[1130]: verbose: UNSET VOLATILE
Jul 09 13:40:49 opera volumio[1130]: info: CorePlayQueue::clearPlayQueue
Jul 09 13:40:49 opera volumio[1130]: info: CorePlayQueue::saveQueue
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::volumioPushQueue
Jul 09 13:40:49 opera volumio[1130]: info:
Jul 09 13:40:49 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:49 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:49 opera volumio[1130]: error: updateQueue error: null
Jul 09 13:40:49 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:49 opera volumio[1130]: info: Starting UPNP Playback
Jul 09 13:40:49 opera volumio[1130]: info: Preparing playback through UPNP
Jul 09 13:40:49 opera volumio[1130]: info: CoreCommandRouter::volumioGetState
Jul 09 13:40:49 opera volumio[1130]: info: CorePlayQueue::getTrack 0
Jul 09 13:40:49 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:50 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:50 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:50 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:50 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:50 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 0ms
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:50 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 1ms
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:50 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces state update: player
Jul 09 13:40:50 opera volumio[1130]: info:
Jul 09 13:40:50 opera volumio[1130]: ---------------------------- MPD announces system playlist update
Jul 09 13:40:50 opera volumio[1130]: info: Ignoring MPD Status Update
Jul 09 13:40:50 opera volumio[1130]: info: ControllerMpd::getState
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status
Jul 09 13:40:50 opera volumio[1130]: info: sendMpdCommand status took 1 milliseconds
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:50 opera volumio[1130]: info: sendMpdCommand status took 2 milliseconds
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 3ms
Jul 09 13:40:50 opera volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::parseState
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:50 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:50 opera volumio[1130]: verbose: In UPNP mode
Jul 09 13:40:50 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":251,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"660 Kbps","isStreaming":false,"title":"Eden","artist":"Edelis","album":"Eden","uri":"http://aqqmusic.tc.qq.com/F000001JQRCN3dzOzu.flac?guid=ffffffffb2377c98000001903a3bdd8f&vkey=F692A324420C7A87559A607B8FF18E7293CD7AA54DC2650AF41A73855F4727B8FBFAB8F41EC682DF5E75D591B8DD42E8E1F5AD6FAD5CBC6B&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""}
Jul 09 13:40:50 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::syncState stateService play
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus stop
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 11ms
Jul 09 13:40:50 opera volumio[1130]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 09 13:40:50 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo
Jul 09 13:40:50 opera volumio[1130]: info: ControllerMpd::pushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::servicePushState
Jul 09 13:40:50 opera volumio[1130]: verbose: In UPNP mode
Jul 09 13:40:50 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":251,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"660 Kbps","isStreaming":false,"title":"Eden","artist":"Edelis","album":"Eden","uri":"http://aqqmusic.tc.qq.com/F000001JQRCN3dzOzu.flac?guid=ffffffffb2377c98000001903a3bdd8f&vkey=F692A324420C7A87559A607B8FF18E7293CD7AA54DC2650AF41A73855F4727B8FBFAB8F41EC682DF5E75D591B8DD42E8E1F5AD6FAD5CBC6B&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""}
Jul 09 13:40:50 opera volumio[1130]: verbose: CURRENT POSITION 0
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::syncState stateService play
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play
Jul 09 13:40:50 opera volumio[1130]: info: Received an update from plugin. extracting info from payload
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::pushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::volumioPushState
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 13:40:50 opera volumio[1130]: info: ------------------------------ 18ms
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:50 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:50 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue
Jul 09 13:40:50 opera volumio[1130]: info: CoreStateMachine::getQueue
Jul 09 13:40:50 opera volumio[1130]: info: CorePlayQueue::getQueue
Jul 09 13:40:50 opera volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%95%B7%E6%B8%95%E5%89%9B/Tsuyoshi%20Nagabuchi%20All%20Time%20Best%202014%20%E5%82%B7%E3%81%A4%E3%81%8D%E6%89%93%E3%81%A1%E3%81%AE%E3%82%81%E3%81%95%E3%82%8C%E3%81%A6%E3%82%82%E3%80%81%E9%95%B7%E6%B8%95%E5%89%9B%E3%80%82/b6190f3c-6672-4f9b-8939-4d38d7a5bb03.jpg'
Jul 09 13:41:22 opera volumio[1130]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 13:41:22 opera volumio[1130]: { Error: connect ETIMEDOUT 108.160.162.115:443
Jul 09 13:41:22 opera volumio[1130]: at Object._errnoException (util.js:1022:11)
Jul 09 13:41:22 opera volumio[1130]: at _exceptionWithHostPort (util.js:1044:20)
Jul 09 13:41:22 opera volumio[1130]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Jul 09 13:41:22 opera volumio[1130]: code: 'ETIMEDOUT',
Jul 09 13:41:22 opera volumio[1130]: errno: 'ETIMEDOUT',
Jul 09 13:41:22 opera volumio[1130]: syscall: 'connect',
Jul 09 13:41:22 opera volumio[1130]: address: '108.160.162.115',
Jul 09 13:41:22 opera volumio[1130]: port: 443 }
Jul 09 13:41:22 opera volumio[1130]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 13:41:23 opera sudo[7045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-09 13:40
Jul 09 13:41:23 opera sudo[7045]: 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="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="opera"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Oct 1 16:18:39 CEST 2021"
VOLUMIO_VERSION="1.031"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_VENDOR="Opera Consonance"
VOLUMIO_MODEL="X5"
VOLUMIO_VENDOR_MODEL="Opera X5"
VOLUMIO_HASH="8579bfbfd528c599f57acb0dd7167775"