-- Logs begin at Sun 2024-03-31 05:06:50 UTC, end at Sat 2024-04-06 10:52:10 UTC. --
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::ClearQueue
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::stop
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:02 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::stPlaybackTimer
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::updateTrackBlock
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrackBlock
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::serviceStop
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::serviceStop
Apr 06 10:51:02 opera volumio[12884]: info: ControllerMpd::stop
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::clearPlayQueue
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::saveQueue
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPushQueue
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::addQueueItems
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::addQueueItems
Apr 06 10:51:02 opera volumio[12884]: info: Adding Item to queue: albums://%E8%94%A1%E7%90%B4/%E9%87%91%E5%A3%B0%E5%9B%9E%E5%BF%86%E5%BD%95101%20Vol.3%20CD5
Apr 06 10:51:02 opera volumio[12884]: info: Exploding uri albums://%E8%94%A1%E7%90%B4/%E9%87%91%E5%A3%B0%E5%9B%9E%E5%BF%86%E5%BD%95101%20Vol.3%20CD5 in service mpd
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::saveQueue
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPushQueue
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::updateTrackBlock
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrackBlock
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPlay
Apr 06 10:51:02 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::play index 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::stop
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:02 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::play index undefined
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::startPlaybackTimer
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::clearAddPlayTracks USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RTT2DVE/蔡琴 - 金聲回憶錄101 Vol.3 CD5 WAV/01 蔡琴 - 恰似你的溫柔.wav
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:02 opera volumio[12884]: info:
Apr 06 10:51:02 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand stop took 34 milliseconds
Apr 06 10:51:02 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand stop took 10 milliseconds
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand clear
Apr 06 10:51:02 opera volumio[12884]: info:
Apr 06 10:51:02 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:02 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand status took 2 milliseconds
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand clear took 3 milliseconds
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RTT2DVE/蔡琴 - 金聲回憶錄101 Vol.3 CD5 WAV/01 蔡琴 - 恰似你的溫柔.wav"
Apr 06 10:51:02 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:02 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:02 opera volumio[12884]: error: updateQueue error: null
Apr 06 10:51:02 opera volumio[12884]: info:
Apr 06 10:51:02 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:02 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:02 opera volumio[12884]: info: ------------------------------ 14ms
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand playlistinfo took 13 milliseconds
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RTT2DVE/蔡琴 - 金聲回憶錄101 Vol.3 CD5 WAV/01 蔡琴 - 恰似你的溫柔.wav" took 13 milliseconds
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand play
Apr 06 10:51:02 opera volumio[12884]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 06 10:51:02 opera volumio[12884]: info: ------------------------------ 19ms
Apr 06 10:51:02 opera volumio[12884]: info: ------------------------------ 6ms
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand play took 4 milliseconds
Apr 06 10:51:02 opera volumio[12884]: info:
Apr 06 10:51:02 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:02 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:02 opera volumio[12884]: info:
Apr 06 10:51:02 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:02 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand status took 3 milliseconds
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand status took 4 milliseconds
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:02 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 蔡琴 - 恰似你的溫柔.wav","artist":"蔡琴","album":"金声回忆录101 Vol.3 CD5","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RTT2DVE/蔡琴 - 金聲回憶錄101 Vol.3 CD5 WAV/01 蔡琴 - 恰似你的溫柔.wav","trackType":"wav"}
Apr 06 10:51:02 opera volumio[12884]: verbose: CURRENT POSITION 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus stop
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:02 opera volumio[12884]: info: ------------------------------ 19ms
Apr 06 10:51:02 opera volumio[12884]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 06 10:51:02 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:02 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 蔡琴 - 恰似你的溫柔.wav","artist":"蔡琴","album":"金声回忆录101 Vol.3 CD5","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RTT2DVE/蔡琴 - 金聲回憶錄101 Vol.3 CD5 WAV/01 蔡琴 - 恰似你的溫柔.wav","trackType":"wav"}
Apr 06 10:51:02 opera volumio[12884]: verbose: CURRENT POSITION 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus play
Apr 06 10:51:02 opera volumio[12884]: info: Received an update from plugin. extracting info from payload
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:02 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:02 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:02 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:02 opera volumio[12884]: info: ------------------------------ 30ms
Apr 06 10:51:02 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:02 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:02 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::ClearQueue
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::stop
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:06 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::stPlaybackTimer
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::updateTrackBlock
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrackBlock
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::serviceStop
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::serviceStop
Apr 06 10:51:06 opera volumio[12884]: info: ControllerMpd::stop
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::clearPlayQueue
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::saveQueue
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPushQueue
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::addQueueItems
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::addQueueItems
Apr 06 10:51:06 opera volumio[12884]: info: Adding Item to queue: albums://%E9%84%A7%E9%BA%97%E5%90%9B/Teresa%20Teng%20Top%20Ten%20-%20Japan%20Taurus%2030TX-1076
Apr 06 10:51:06 opera volumio[12884]: info: Exploding uri albums://%E9%84%A7%E9%BA%97%E5%90%9B/Teresa%20Teng%20Top%20Ten%20-%20Japan%20Taurus%2030TX-1076 in service mpd
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::saveQueue
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPushQueue
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::updateTrackBlock
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrackBlock
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPlay
Apr 06 10:51:06 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::play index 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::stop
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:06 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::play index undefined
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::startPlaybackTimer
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::clearAddPlayTracks USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RUWB650/01 つぐない.flac
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:06 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:06 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:06 opera volumio[12884]: info:
Apr 06 10:51:06 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand stop took 59 milliseconds
Apr 06 10:51:06 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand stop took 33 milliseconds
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand status took 1 milliseconds
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand clear
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:06 opera volumio[12884]: info:
Apr 06 10:51:06 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:06 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand clear took 2 milliseconds
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RUWB650/01 つぐない.flac"
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:06 opera volumio[12884]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 06 10:51:06 opera volumio[12884]: info: ------------------------------ 7ms
Apr 06 10:51:06 opera volumio[12884]: error: updateQueue error: null
Apr 06 10:51:06 opera volumio[12884]: info:
Apr 06 10:51:06 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:06 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:06 opera volumio[12884]: info: ------------------------------ 4ms
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RUWB650/01 つぐない.flac" took 3 milliseconds
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand play
Apr 06 10:51:06 opera volumio[12884]: info: ------------------------------ 3ms
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand play took 2 milliseconds
Apr 06 10:51:06 opera volumio[12884]: info:
Apr 06 10:51:06 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:06 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:06 opera volumio[12884]: info:
Apr 06 10:51:06 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand status took 2 milliseconds
Apr 06 10:51:06 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand status took 2 milliseconds
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:06 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"つぐない","artist":"鄧麗君","album":"Teresa Teng Top Ten - Japan Taurus 30TX-1076","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RUWB650/01 つぐない.flac","trackType":"flac"}
Apr 06 10:51:06 opera volumio[12884]: verbose: CURRENT POSITION 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus stop
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:06 opera volumio[12884]: info: ------------------------------ 17ms
Apr 06 10:51:06 opera volumio[12884]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 06 10:51:06 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:06 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"592 Kbps","isStreaming":false,"title":"つぐない","artist":"鄧麗君","album":"Teresa Teng Top Ten - Japan Taurus 30TX-1076","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RUWB650/01 つぐない.flac","trackType":"flac"}
Apr 06 10:51:06 opera volumio[12884]: verbose: CURRENT POSITION 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus play
Apr 06 10:51:06 opera volumio[12884]: info: Received an update from plugin. extracting info from payload
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:06 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:06 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:06 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:06 opera volumio[12884]: info: ------------------------------ 32ms
Apr 06 10:51:06 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:06 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:06 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::ClearQueue
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::stop
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:12 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::stPlaybackTimer
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::updateTrackBlock
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrackBlock
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::serviceStop
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::serviceStop
Apr 06 10:51:12 opera volumio[12884]: info: ControllerMpd::stop
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::clearPlayQueue
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::saveQueue
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPushQueue
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::addQueueItems
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::addQueueItems
Apr 06 10:51:12 opera volumio[12884]: info: Adding Item to queue: albums://%E6%9E%97%E6%86%B6%E8%93%AE/%E7%B2%BE%E9%81%B816%E9%A6%96%20SACD%20Best%20Collection%20
Apr 06 10:51:12 opera volumio[12884]: info: Exploding uri albums://%E6%9E%97%E6%86%B6%E8%93%AE/%E7%B2%BE%E9%81%B816%E9%A6%96%20SACD%20Best%20Collection%20 in service mpd
Apr 06 10:51:12 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:12 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::saveQueue
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPushQueue
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::updateTrackBlock
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrackBlock
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPlay
Apr 06 10:51:12 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::play index 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::stop
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:12 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::play index undefined
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::startPlaybackTimer
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::clearAddPlayTracks USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/01 - 難忘您.flac
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand stop took 101 milliseconds
Apr 06 10:51:12 opera volumio[12884]: info:
Apr 06 10:51:12 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:12 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand stop took 63 milliseconds
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand clear
Apr 06 10:51:12 opera volumio[12884]: info:
Apr 06 10:51:12 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:12 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand status took 3 milliseconds
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand clear took 3 milliseconds
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/01 - 難忘您.flac"
Apr 06 10:51:12 opera volumio[12884]: error: updateQueue error: null
Apr 06 10:51:12 opera volumio[12884]: info:
Apr 06 10:51:12 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:12 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:12 opera volumio[12884]: info: ------------------------------ 7ms
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/01 - 難忘您.flac" took 4 milliseconds
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand play
Apr 06 10:51:12 opera volumio[12884]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 06 10:51:12 opera volumio[12884]: info: ------------------------------ 13ms
Apr 06 10:51:12 opera volumio[12884]: info: ------------------------------ 5ms
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand play took 3 milliseconds
Apr 06 10:51:12 opera volumio[12884]: info:
Apr 06 10:51:12 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:12 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:12 opera volumio[12884]: info:
Apr 06 10:51:12 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand status took 28 milliseconds
Apr 06 10:51:12 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand status took 2 milliseconds
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:12 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":254,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - 難忘您","artist":"林憶蓮","album":"精選16首 SACD Best Collection ","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/01 - 難忘您.flac","trackType":"flac"}
Apr 06 10:51:12 opera volumio[12884]: verbose: CURRENT POSITION 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus stop
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:12 opera volumio[12884]: info: ------------------------------ 50ms
Apr 06 10:51:12 opera volumio[12884]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 06 10:51:12 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:12 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":254,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"360 Kbps","isStreaming":false,"title":"01 - 難忘您","artist":"林憶蓮","album":"精選16首 SACD Best Collection ","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/01 - 難忘您.flac","trackType":"flac"}
Apr 06 10:51:12 opera volumio[12884]: verbose: CURRENT POSITION 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus play
Apr 06 10:51:12 opera volumio[12884]: info: Received an update from plugin. extracting info from payload
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:12 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:12 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:12 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:12 opera volumio[12884]: info: ------------------------------ 42ms
Apr 06 10:51:12 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:12 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:12 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:22 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pink%20Floyd/Wish%20You%20Were%20Here%20-%20Immersion%20Edition%20Bluray/ec12fba6-7093-4e39-80d7-7ef6b2ee396f.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Beatles/Abbey%20Road%20(24%20BIT%20Remastered)/f6ede1bc-2800-4208-86cf-dec2c1a1f5cb.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yes/Almost%20Famous/062ea8ad-06ff-4d56-b16b-8fe98c5fdc6f.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Radiohead/Amnesiac/fb6b5407-8527-4d0b-9f60-1222dcf36735.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Michelle%20Shocked/Dead%20Man%20Walking/a914f2aa-184a-43ef-a50d-10efb583bb64.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Who/Endless%20Wire/ad7c6773-6df4-4e1e-beb2-18b0ed092a24.png'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Shirley%20Horn/Here%27s%20To%20Life/1e005cd7-a5bf-47e2-aa9b-614fb5955417.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Shirley%20Horn/I%20Remember%20Miles/73b404f6-d9f3-49d5-ae3f-1e8d3df0a237.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Radiohead/In%20Rainbows/bc0cb21e-15b1-442a-a451-c1cf305aea24.png'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Who/It%27s%20Hard/7b12121d-f650-482d-b500-d0c8d58819c9.png'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jimi%20Hendrix/Jimi%20Blues/4b918fa6-e29b-40b1-8067-7ca7cc1f6dec.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20New%20Basement%20Tapes/Lost%20On%20The%20River%20(Deluxe)/cce0fe5b-eab9-415e-ae19-63ba2f7c91b5.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dialogue/Napoleon%20Dynamite/56720c99-bad0-4a1e-ae42-3c87792c25d6.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Manu%20Katch%C3%A9/Neighbourhood/8bc8762d-8e37-4a25-bdbb-3fcc66168244.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Leonard%20Cohen/Old%20Ideas/7b510800-1be1-4ea8-99ec-2449990570e6.png'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Rickie%20Lee%20Jones/Pop%20Pop/ce62c234-6c5b-485b-b688-09b25207600e.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dusty%20Springfield/Pulp%20Fiction/014533bf-4254-4598-84c5-62757137fefb.png'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Beatles/Revolver%20(24%20BIT%20Remastered)/873b07c7-3ed0-48ae-9b7c-de126802dba2.jpg'
Apr 06 10:51:23 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Fairfield%20Four/Standing%20In%20The%20Safety%20Zone/7d8c5f10-0133-4969-8e2d-28c43fdd2e1d.jpg'
Apr 06 10:51:24 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sarah%20McLachlan/Surfacing/d598de60-57b4-499d-b442-2fe6a7a9b68e.png'
Apr 06 10:51:24 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eminem/The%20Eminem%20Show/656b100a-9725-47a1-8aaf-59a6c71ba023.jpg'
Apr 06 10:51:24 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Annie%20Lennox/The%20Unplugged%20Collection%20Volume%20One/4225a9fb-287e-4ec2-a7bd-84375ce1a1aa.jpg'
Apr 06 10:51:24 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pink%20Floyd/Wish%20You%20Were%20Here/a96fdfc4-a543-441d-8a82-d0e543dad976.png'
Apr 06 10:51:24 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Shirley%20Horn/You%20Won%27t%20Forget%20Me/dade835d-eec7-43a3-baf1-884787dec944.jpg'
Apr 06 10:51:25 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hiromi/Alive/2d160b23-0887-4d49-817e-271b27954ee2.jpg'
Apr 06 10:51:25 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joni%20Mitchell/Both%20Sides%20Now/9ca6c430-dbbe-473c-97bf-d4de2dcad4ac.jpg'
Apr 06 10:51:25 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Paul%20Simon/Graceland%20(25th%20Anniversary%20Edition)/18647036-3832-49dd-9a06-816648229efe.jpg'
Apr 06 10:51:25 opera volumio[12884]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Peter%20Gabriel/So%20(Remastered%202012)/e60dc855-99ba-427c-863b-850d00ff7603.jpg'
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::volumioPlay
Apr 06 10:51:27 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::play index 1
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::stop
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:27 opera volumio[12884]: verbose: UNSET VOLATILE
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::stPlaybackTimer
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::updateTrackBlock
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrackBlock
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::serviceStop
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::serviceStop
Apr 06 10:51:27 opera volumio[12884]: info: ControllerMpd::stop
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:27 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand stop took 51 milliseconds
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::play index undefined
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 1
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::startPlaybackTimer
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 1
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::clearAddPlayTracks USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/02 - 三更半夜.flac
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:51:27 opera volumio[12884]: info:
Apr 06 10:51:27 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:27 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand stop took 4 milliseconds
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand clear
Apr 06 10:51:27 opera volumio[12884]: info:
Apr 06 10:51:27 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:27 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand status took 3 milliseconds
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand clear took 4 milliseconds
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/02 - 三更半夜.flac"
Apr 06 10:51:27 opera volumio[12884]: error: updateQueue error: null
Apr 06 10:51:27 opera volumio[12884]: info:
Apr 06 10:51:27 opera volumio[12884]: ---------------------------- MPD announces system playlist update
Apr 06 10:51:27 opera volumio[12884]: info: Ignoring MPD Status Update
Apr 06 10:51:27 opera volumio[12884]: info: ------------------------------ 4ms
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/02 - 三更半夜.flac" took 2 milliseconds
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand play
Apr 06 10:51:27 opera volumio[12884]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 06 10:51:27 opera volumio[12884]: info: ------------------------------ 11ms
Apr 06 10:51:27 opera volumio[12884]: info: ------------------------------ 5ms
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand play took 2 milliseconds
Apr 06 10:51:27 opera volumio[12884]: info:
Apr 06 10:51:27 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:27 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:27 opera volumio[12884]: info:
Apr 06 10:51:27 opera volumio[12884]: ---------------------------- MPD announces state update: player
Apr 06 10:51:27 opera volumio[12884]: info: ControllerMpd::getState
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand status took 4 milliseconds
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand status took 3 milliseconds
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::parseState
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:27 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 1
Apr 06 10:51:27 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":250,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3426 Kbps","isStreaming":false,"title":"02 - 三更半夜","artist":"林憶蓮","album":"精選16首 SACD Best Collection ","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/02 - 三更半夜.flac","trackType":"flac"}
Apr 06 10:51:27 opera volumio[12884]: verbose: CURRENT POSITION 1
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus stop
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 1
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:27 opera volumio[12884]: info: ------------------------------ 26ms
Apr 06 10:51:27 opera volumio[12884]: info: sendMpdCommand playlistinfo took 13 milliseconds
Apr 06 10:51:27 opera volumio[12884]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:51:27 opera volumio[12884]: info: ControllerMpd::pushState
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::servicePushState
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 1
Apr 06 10:51:27 opera volumio[12884]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":250,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3426 Kbps","isStreaming":false,"title":"02 - 三更半夜","artist":"林憶蓮","album":"精選16首 SACD Best Collection ","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/02 - 三更半夜.flac","trackType":"flac"}
Apr 06 10:51:27 opera volumio[12884]: verbose: CURRENT POSITION 1
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::syncState stateService play
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::syncState currentStatus play
Apr 06 10:51:27 opera volumio[12884]: info: Received an update from plugin. extracting info from payload
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 1
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:27 opera volumio[12884]: info: CoreStateMachine::pushState
Apr 06 10:51:27 opera volumio[12884]: info: CorePlayQueue::getTrack 1
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:27 opera volumio[12884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:27 opera volumio[12884]: info: ------------------------------ 34ms
Apr 06 10:51:27 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:27 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:27 opera volumio[12884]: info: Updating RAAT Signal Path
Apr 06 10:51:28 opera volumio[12884]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 06 10:51:28 opera volumio[12884]: { Error: connect ETIMEDOUT 69.171.229.73:443
Apr 06 10:51:28 opera volumio[12884]: at Object._errnoException (util.js:1022:11)
Apr 06 10:51:28 opera volumio[12884]: at _exceptionWithHostPort (util.js:1044:20)
Apr 06 10:51:28 opera volumio[12884]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Apr 06 10:51:28 opera volumio[12884]: code: 'ETIMEDOUT',
Apr 06 10:51:28 opera volumio[12884]: errno: 'ETIMEDOUT',
Apr 06 10:51:28 opera volumio[12884]: syscall: 'connect',
Apr 06 10:51:28 opera volumio[12884]: address: '69.171.229.73',
Apr 06 10:51:28 opera volumio[12884]: port: 443 }
Apr 06 10:51:28 opera volumio[12884]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 06 10:51:29 opera sudo[13573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-06 10:50
Apr 06 10:51:29 opera sudo[13573]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:29 opera sudo[13573]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:35 opera volumio-remote-updater[689]: [2024-04-06 10:51:35] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 06 10:51:35 opera volumio-remote-updater[689]: [2024-04-06 10:51:35] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 06 10:51:35 opera systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Apr 06 10:51:35 opera systemd[1]: Unit volumio.service entered failed state.
Apr 06 10:51:35 opera systemd[1]: Starting dynamicswap service...
Apr 06 10:51:35 opera systemd[1]: Started dynamicswap service.
Apr 06 10:51:35 opera systemd[1]: volumio.service holdoff time over, scheduling restart.
Apr 06 10:51:35 opera systemd[1]: Starting dynamicswap service...
Apr 06 10:51:35 opera systemd[1]: Started dynamicswap service.
Apr 06 10:51:35 opera systemd[1]: Stopping Volumio Backend Module...
Apr 06 10:51:35 opera systemd[1]: Starting Volumio Backend Module...
Apr 06 10:51:35 opera systemd[1]: Started Volumio Backend Module.
Apr 06 10:51:36 opera volumio[13601]: info: -------------------------------------------
Apr 06 10:51:36 opera volumio[13601]: info: ----- Volumio2 ----
Apr 06 10:51:36 opera volumio[13601]: info: -------------------------------------------
Apr 06 10:51:36 opera volumio[13601]: info: ----- System startup ----
Apr 06 10:51:36 opera volumio[13601]: info: -------------------------------------------
Apr 06 10:51:36 opera volumio[13601]: info: Plugin folders cleanup
Apr 06 10:51:36 opera volumio[13601]: info: Scanning into folder /volumio/app/plugins/
Apr 06 10:51:36 opera volumio[13601]: info: Scanning category audio_interface
Apr 06 10:51:36 opera volumio[13601]: info: Scanning category miscellanea
Apr 06 10:51:36 opera volumio[13601]: info: Scanning category music_service
Apr 06 10:51:36 opera volumio[13601]: info: Scanning category plugins.json
Apr 06 10:51:36 opera volumio[13601]: info: Scanning category system_controller
Apr 06 10:51:36 opera volumio[13601]: info: Scanning category user_interface
Apr 06 10:51:36 opera volumio[13601]: info: Scanning into folder /data/plugins/
Apr 06 10:51:36 opera volumio[13601]: info: Plugin folders cleanup completed
Apr 06 10:51:36 opera volumio[13601]: info: -------------------------------------------
Apr 06 10:51:36 opera volumio[13601]: info: ----- Core plugins startup ----
Apr 06 10:51:36 opera volumio[13601]: info: -------------------------------------------
Apr 06 10:51:36 opera volumio[13601]: info: Loading plugins from folder /volumio/app/plugins/
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin upnp to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin raat to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Adding plugin volspotconnect2 to MyMusic Plugins
Apr 06 10:51:36 opera volumio[13601]: info: Loading plugins from folder /data/plugins/
Apr 06 10:51:36 opera volumio[13601]: info: Loading plugin "system"...
Apr 06 10:51:36 opera volumio[13601]: info: Loading plugin "appearance"...
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "network"...
Apr 06 10:51:37 opera volumio[13601]: info: Refreshing Cached IP Addresses
Apr 06 10:51:37 opera sudo[13626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "services"...
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "alsa_controller"...
Apr 06 10:51:37 opera sudo[13626]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:37 opera sudo[13629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 06 10:51:37 opera sudo[13626]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:37 opera sudo[13629]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:37 opera sudo[13629]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "wizard"...
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "volumio_command_line_client"...
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "upnp"...
Apr 06 10:51:37 opera volumio[13601]: info: [1712400697690] Starting Upmpd Daemon
Apr 06 10:51:37 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "my_music"...
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "mpd"...
Apr 06 10:51:37 opera volumio[13601]: info: Loading plugin "upnp_browser"...
Apr 06 10:51:38 opera volumio[13601]: info: Loading plugin "networkfs"...
Apr 06 10:51:38 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 06 10:51:38 opera volumio[13601]: info: Loading plugin "bluetooth"...
Apr 06 10:51:38 opera volumio[13601]: info: [1712400698322] Starting BluetoothController
Apr 06 10:51:38 opera volumio[13601]: info: Loading plugin "alarm-clock"...
Apr 06 10:51:38 opera volumio[13601]: info: Loading plugin "metavolumio"...
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "airplay_emulation"...
Apr 06 10:51:39 opera volumio[13601]: info: Starting Shairport Sync
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "cd_controller"...
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "last_100"...
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "raat"...
Apr 06 10:51:39 opera volumio[13601]: info: RAAT Plugin loaded
Apr 06 10:51:39 opera volumio[13601]: info: Adding restartRAATSocket REST API Endpoint
Apr 06 10:51:39 opera volumio[13601]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "streaming_services"...
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "webradio"...
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "i2s_dacs"...
Apr 06 10:51:39 opera volumio[13601]: info: I2S DAC not set, start Auto-detection
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "volumiodiscovery"...
Apr 06 10:51:39 opera volumio[13601]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 06 10:51:39 opera node[13601]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 06 10:51:39 opera volumio[13601]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 06 10:51:39 opera node[13601]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 06 10:51:39 opera volumio[13601]: *** WARNING *** For more information see
Apr 06 10:51:39 opera node[13601]: *** WARNING *** For more information see
Apr 06 10:51:39 opera volumio[13601]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 06 10:51:39 opera node[13601]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 06 10:51:39 opera volumio[13601]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 06 10:51:39 opera node[13601]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 06 10:51:39 opera volumio[13601]: *** WARNING *** For more information see
Apr 06 10:51:39 opera node[13601]: *** WARNING *** For more information see
Apr 06 10:51:39 opera volumio[13601]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 06 10:51:39 opera volumio[13601]: Discovery: StartAdv! undefined
Apr 06 10:51:39 opera volumio[13601]: Discovery: Started advertising... Opera-3 - undefined
Apr 06 10:51:39 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "outputs"...
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "albumart"...
Apr 06 10:51:39 opera volumio[13601]: info: Plugin example_plugin is not enabled
Apr 06 10:51:39 opera volumio[13601]: info: Loading plugin "hi_res_audio"...
Apr 06 10:51:39 opera volumio[13601]: Forking 3 albumart workers
Apr 06 10:51:40 opera volumio-remote-updater[689]: [2024-04-06 10:51:40] [connect] Successful connection
Apr 06 10:51:40 opera volumio[13601]: Starting albumart workers
Apr 06 10:51:40 opera volumio[13601]: Starting albumart workers
Apr 06 10:51:40 opera volumio[13601]: Starting albumart workers
Apr 06 10:51:40 opera volumio[13601]: info: Applying required configuration parameters for plugin hi_res_audio
Apr 06 10:51:40 opera volumio[13601]: info: Loading plugin "inputs"...
Apr 06 10:51:40 opera volumio[13601]: info: Loading plugin "qobuz"...
Apr 06 10:51:41 opera volumio[13601]: info: Loading plugin "tidal"...
Apr 06 10:51:42 opera volumio[13601]: info: Loading plugin "volspotconnect2"...
Apr 06 10:51:42 opera volumio[13601]: info: Loading plugin "updater_comm"...
Apr 06 10:51:42 opera volumio[13601]: info: Plugin mpdemulation is not enabled
Apr 06 10:51:42 opera volumio[13601]: info: Loading plugin "rest_api"...
Apr 06 10:51:42 opera volumio[13601]: info: Loading plugin "websocket"...
Apr 06 10:51:42 opera volumio[13601]: info: ___________ START PLUGINS ___________
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 06 10:51:42 opera volumio[13601]: info: [1712400702782] CoreMusicLibrary::Adding element Media Servers
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 06 10:51:42 opera volumio[13601]: info: Adding METAVOLUMIO REST API Endpoints
Apr 06 10:51:42 opera volumio[13601]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Apr 06 10:51:42 opera sudo[13703]: pam_unix(sudo:auth): conversation failed
Apr 06 10:51:42 opera sudo[13703]: pam_unix(sudo:auth): auth could not identify password for [volumio]
Apr 06 10:51:42 opera volumio[13601]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 06 10:51:42 opera volumio[13601]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 06 10:51:42 opera volumio[13601]: info: Preparing CD Folders
Apr 06 10:51:42 opera volumio[13601]: info: Adding CD REST API Endpoints
Apr 06 10:51:42 opera volumio[13601]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller
Apr 06 10:51:42 opera volumio[13601]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller
Apr 06 10:51:42 opera volumio[13601]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller
Apr 06 10:51:42 opera volumio[13601]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Apr 06 10:51:42 opera volumio[13601]: info: Detecting CD presence with Flag file
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 06 10:51:42 opera volumio[13601]: info: [1712400702894] CoreMusicLibrary::Adding element Last_100
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 10:51:42 opera volumio[13601]: info: Starting RAAT Plugin
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections
Apr 06 10:51:42 opera volumio[13601]: info: Additional UI Settings Added for plugin music_service/raat
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 10:51:42 opera volumio[13601]: info: Streaming services startup
Apr 06 10:51:42 opera volumio[13601]: info: Starting Streaming Daemon
Apr 06 10:51:42 opera sudo[13718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 06 10:51:42 opera sudo[13718]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:42 opera systemd[1]: Stopping Volumio Streaming Daemon...
Apr 06 10:51:42 opera systemd[1]: Starting Volumio Streaming Daemon...
Apr 06 10:51:42 opera systemd[1]: Started Volumio Streaming Daemon.
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 06 10:51:42 opera volumio[13601]: info: [1712400702971] CoreMusicLibrary::Adding element Webradio
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 10:51:42 opera sudo[13718]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:42 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 06 10:51:42 opera volumio[13601]: error: Hi Res Audio Failed Login: Missing Login Data
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: ############################
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: # Volumio Streaming Daemon #
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: # Running on port 7777 #
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: ############################
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: Checking variant in static cache
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: Enabled services:
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: 1) tidal
Apr 06 10:51:42 opera volumio-streaming-daemon[13728]: 2) qobuz
Apr 06 10:51:43 opera volumio[13601]: info: Loading i18n strings for locale zh
Apr 06 10:51:43 opera volumio[13601]: Updating browse sources language
Apr 06 10:51:43 opera volumio[13601]: Cannot find translation for sourceMedia Servers
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 10:51:43 opera sudo[13740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service
Apr 06 10:51:43 opera sudo[13740]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::initPlayerControls
Apr 06 10:51:43 opera systemd[1]: Started Volspotconnect2 Daemon.
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Apr 06 10:51:43 opera sudo[13740]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: BOOT COMPLETED
Apr 06 10:51:43 opera volumio[13601]: [Metrics] CommandRouter: 6s 646.43ms
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: aplay: main:722: audio open error: Device or resource busy
Apr 06 10:51:43 opera volumio[13601]: Cannot play startup sound
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::Close All Modals sent
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::Close All Modals sent
Apr 06 10:51:43 opera volumio[13601]: Express server listening on port 3000
Apr 06 10:51:43 opera volumio[13601]: [Metrics] WebUI: 7s 15.34ms
Apr 06 10:51:43 opera volumio[13601]: Volumio Calling Home
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::resetVolumioState
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::getcurrentVolume
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioRetrievevolume
Apr 06 10:51:43 opera volumio[13601]: info: Stopping AccessToken refresher cron for QOBUZ
Apr 06 10:51:43 opera volumio[13601]: info: AccessToken refresher cron started for QOBUZ
Apr 06 10:51:43 opera volumio[13601]: info: Stopping AccessToken refresher cron
Apr 06 10:51:43 opera volumio[13601]: info: AccessToken refresher cron started
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::pushState
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:43 opera volumio[13601]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 06 10:51:43 opera volumio[13601]: info: Setting Device type: Tinkerboard
Apr 06 10:51:43 opera volumio[13601]: [SpotifyConnect] Vollibrespot Daemon Started
Apr 06 10:51:43 opera volumio[13601]: [SpotifyConnect] Starting metadata listener
Apr 06 10:51:43 opera volumio[13601]: [SpotifyConnect] FE => [ 1, [length]: 1 ]
Apr 06 10:51:43 opera volumio[13601]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Opera-3'
Apr 06 10:51:43 opera volumio[13601]: We trust you have received the usual lecture from the local System
Apr 06 10:51:43 opera volumio[13601]: Administrator. It usually boils down to these three things:
Apr 06 10:51:43 opera volumio[13601]: #1) Respect the privacy of others.
Apr 06 10:51:43 opera volumio[13601]: #2) Think before you type.
Apr 06 10:51:43 opera volumio[13601]: #3) With great power comes great responsibility.
Apr 06 10:51:43 opera volumio[13601]: sudo: no tty present and no askpass program specified
Apr 06 10:51:43 opera volumio[13601]: info: MPD running with PID723
Apr 06 10:51:43 opera volumio[13601]: ,establishing connection
Apr 06 10:51:43 opera sudo[13760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Apr 06 10:51:43 opera sudo[13760]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:43 opera sudo[13760]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:43 opera volumio-remote-updater[689]: [2024-04-06 10:51:43] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1712400700 101
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioGetState
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 06 10:51:43 opera volumio[13601]: info: Reloading queue from file
Apr 06 10:51:43 opera sudo[13772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Apr 06 10:51:43 opera sudo[13772]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:43 opera systemd[1]: Stopping RAAT DAEMON...
Apr 06 10:51:43 opera systemd[1]: Starting RAAT DAEMON...
Apr 06 10:51:43 opera systemd[1]: Started RAAT DAEMON.
Apr 06 10:51:43 opera sudo[13772]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::setRepeat true single undefined
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::pushState
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::setRandom false
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::pushState
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioPushState
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:51:43 opera volumio[13601]: info: Raat Daemon started successfully
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioGetState
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioGetQueue
Apr 06 10:51:43 opera volumio[13601]: info: CoreStateMachine::getQueue
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getQueue
Apr 06 10:51:43 opera volumio[13601]: info: Listing playlists
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 06 10:51:43 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:43 opera volumio[13601]: info: Executing endpoint restartRAATSocket
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Apr 06 10:51:43 opera volumio[13601]: info: CoreCommandRouter::volumioGetState
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:43 opera volumio[13601]: info: Starting Shairport Sync
Apr 06 10:51:43 opera volumio[13601]: info: Starting Shairport Sync
Apr 06 10:51:43 opera sudo[13795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 06 10:51:43 opera sudo[13795]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:43 opera sudo[13798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 06 10:51:43 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 06 10:51:43 opera sudo[13798]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:43 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Apr 06 10:51:43 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 06 10:51:43 opera sudo[13795]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:43 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 06 10:51:43 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Apr 06 10:51:43 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 06 10:51:43 opera sudo[13798]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:43 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:43 opera volumio[13601]: info: Shairport-Sync Started
Apr 06 10:51:43 opera volumio[13601]: Error adding Membership: Error: addMembership EINVAL
Apr 06 10:51:43 opera volumio[13601]: info: Shairport-Sync Started
Apr 06 10:51:44 opera volumio[13601]: Discovery: adding 64ef0dd6-d70c-4d95-8e42-9d9011e2cc05
Apr 06 10:51:44 opera volumio[13601]: info: mDNS: Found device Opera-3
Apr 06 10:51:44 opera volumio[13601]: info: CoreCommandRouter::volumioGetState
Apr 06 10:51:44 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:44 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:44 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:44 opera volumio[13601]: Discovery: this is already registered, 64ef0dd6-d70c-4d95-8e42-9d9011e2cc05
Apr 06 10:51:44 opera volumio[13601]: info: mDNS: Found device Opera-3
Apr 06 10:51:44 opera volumio[13601]: info: CoreCommandRouter::volumioGetState
Apr 06 10:51:44 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:44 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:44 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:44 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 06 10:51:44 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 06 10:51:44 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 06 10:51:44 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 06 10:51:45 opera sudo[13840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Apr 06 10:51:45 opera sudo[13840]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:45 opera systemd[1]: Started Volumio Bluetooth Module.
Apr 06 10:51:45 opera sudo[13840]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:46 opera volumio[13601]: info: CoreCommandRouter::volumioGetState
Apr 06 10:51:46 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:46 opera volumio[13601]: info: Volumio BT Module successfully started
Apr 06 10:51:46 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 06 10:51:46 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:46 opera volumio[13601]: info: Listing playlists
Apr 06 10:51:46 opera volumio-streaming-daemon[13728]: Checking variant in static cache
Apr 06 10:51:46 opera volumio[13601]: info: Fetching Streaming Services browse cache
Apr 06 10:51:46 opera volumio[13601]: info: CoreCommandRouter::volumioGetState
Apr 06 10:51:46 opera volumio[13601]: info: CorePlayQueue::getTrack 0
Apr 06 10:51:47 opera sudo[13852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 06 10:51:47 opera sudo[13852]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:47 opera sudo[13852]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:47 opera sudo[13859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 06 10:51:47 opera sudo[13859]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:47 opera sudo[13859]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:47 opera volumio[13601]: Discovery: adding 89cadb14-f203-4e5d-a3c9-03693fad9740
Apr 06 10:51:47 opera volumio[13601]: info: mDNS: Found device Opera-2
Apr 06 10:51:47 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:47 opera sudo[13871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 06 10:51:47 opera sudo[13871]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 10:51:47 opera systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 06 10:51:47 opera sudo[13871]: pam_unix(sudo:session): session closed for user root
Apr 06 10:51:47 opera volumio[13601]: info: Upmpdcli Daemon Started
Apr 06 10:51:47 opera volumio[13601]: error: Could not retrieve plugin audio_interface multiroom
Apr 06 10:51:57 opera volumio[13601]: info: Volumio called home
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::volumioPlay
Apr 06 10:52:02 opera volumio[13601]: verbose: UNSET VOLATILE
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::play index 15
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::stop
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:52:02 opera volumio[13601]: verbose: UNSET VOLATILE
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::play index undefined
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 10:52:02 opera volumio[13601]: info: CorePlayQueue::getTrack 15
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::startPlaybackTimer
Apr 06 10:52:02 opera volumio[13601]: info: CorePlayQueue::getTrack 15
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::clearAddPlayTracks USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/16 - 情人的眼淚.flac
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 10:52:02 opera volumio[13601]: info:
Apr 06 10:52:02 opera volumio[13601]: ---------------------------- MPD announces state update: player
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand stop took 55 milliseconds
Apr 06 10:52:02 opera volumio[13601]: info: ControllerMpd::getState
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand clear
Apr 06 10:52:02 opera volumio[13601]: info:
Apr 06 10:52:02 opera volumio[13601]: ---------------------------- MPD announces system playlist update
Apr 06 10:52:02 opera volumio[13601]: info: Ignoring MPD Status Update
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand status took 4 milliseconds
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand clear took 3 milliseconds
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::parseState
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/16 - 情人的眼淚.flac"
Apr 06 10:52:02 opera volumio[13601]: error: updateQueue error: null
Apr 06 10:52:02 opera volumio[13601]: info:
Apr 06 10:52:02 opera volumio[13601]: ---------------------------- MPD announces system playlist update
Apr 06 10:52:02 opera volumio[13601]: info: Ignoring MPD Status Update
Apr 06 10:52:02 opera volumio[13601]: info: ------------------------------ 8ms
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand add "USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/16 - 情人的眼淚.flac" took 4 milliseconds
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand play
Apr 06 10:52:02 opera volumio[13601]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 06 10:52:02 opera volumio[13601]: info: ------------------------------ 18ms
Apr 06 10:52:02 opera volumio[13601]: info: ------------------------------ 7ms
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand play took 4 milliseconds
Apr 06 10:52:02 opera volumio[13601]: info:
Apr 06 10:52:02 opera volumio[13601]: ---------------------------- MPD announces state update: player
Apr 06 10:52:02 opera volumio[13601]: info: ControllerMpd::getState
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:52:02 opera volumio[13601]: info:
Apr 06 10:52:02 opera volumio[13601]: ---------------------------- MPD announces state update: player
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand status took 3 milliseconds
Apr 06 10:52:02 opera volumio[13601]: info: ControllerMpd::getState
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand status
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::parseState
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand status took 2 milliseconds
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::parseState
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:52:02 opera volumio[13601]: info: ControllerMpd::pushState
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::servicePushState
Apr 06 10:52:02 opera volumio[13601]: info: CorePlayQueue::getTrack 15
Apr 06 10:52:02 opera volumio[13601]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"16 - 情人的眼淚","artist":"林憶蓮","album":"精選16首 SACD Best Collection ","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/16 - 情人的眼淚.flac","trackType":"flac"}
Apr 06 10:52:02 opera volumio[13601]: verbose: CURRENT POSITION 15
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::syncState stateService play
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::syncState currentStatus stop
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::pushState
Apr 06 10:52:02 opera volumio[13601]: info: CorePlayQueue::getTrack 15
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::volumioPushState
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:52:02 opera volumio[13601]: info: ------------------------------ 23ms
Apr 06 10:52:02 opera volumio[13601]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 06 10:52:02 opera volumio[13601]: verbose: ControllerMpd::parseTrackInfo
Apr 06 10:52:02 opera volumio[13601]: info: ControllerMpd::pushState
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::servicePushState
Apr 06 10:52:02 opera volumio[13601]: info: CorePlayQueue::getTrack 15
Apr 06 10:52:02 opera volumio[13601]: verbose: STATE SERVICE {"status":"play","position":0,"seek":493,"duration":290,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2429 Kbps","isStreaming":false,"title":"16 - 情人的眼淚","artist":"林憶蓮","album":"精選16首 SACD Best Collection ","uri":"USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/16 - 情人的眼淚.flac","trackType":"flac"}
Apr 06 10:52:02 opera volumio[13601]: verbose: CURRENT POSITION 15
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::syncState stateService play
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::syncState currentStatus play
Apr 06 10:52:02 opera volumio[13601]: info: Received an update from plugin. extracting info from payload
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::pushState
Apr 06 10:52:02 opera volumio[13601]: info: CorePlayQueue::getTrack 15
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::volumioPushState
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:52:02 opera volumio[13601]: info: CoreStateMachine::pushState
Apr 06 10:52:02 opera volumio[13601]: info: CorePlayQueue::getTrack 15
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::volumioPushState
Apr 06 10:52:02 opera volumio[13601]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 10:52:02 opera volumio[13601]: info: ------------------------------ 33ms
Apr 06 10:52:02 opera volumio[13601]: info: Updating RAAT Signal Path
Apr 06 10:52:02 opera volumio[13601]: info: Updating RAAT Signal Path
Apr 06 10:52:02 opera volumio[13601]: info: Updating RAAT Signal Path
Apr 06 10:52:06 opera volumio[13601]: info: Adding music-library/USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/16 - 情人的眼淚.flac to favourites using generic method
Apr 06 10:52:06 opera volumio[13601]: info: Saving local item favourites
Apr 06 10:52:06 opera volumio[13601]: info: Pushing Favourites {"uri":"/mnt/USB/PCM..600/$RECYCLE.BIN/S-1-5-21-1118571346-3405995946-3236739600-500/$RY8W11H/林憶蓮 - 精選16首 SACD Best Collection 2004 24-88.2 SACD/16 - 情人的眼淚.flac","favourite":false}
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joachim%20Eijlander/Bach%20Cello%20Suites%20Vol.1/9e3f3d43-e9c3-49c5-93ee-13bbf8a02b9b.jpg'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ben%20Webster/The%20Soul%20Of%20Ben%20Webster/3401c015-20f0-436a-a498-f246db317477.png'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pacho%20Flores/Cantar/41fa11e7-bb8e-44ec-b830-1b061c276550.png'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Nordic%20Brass%20Ensemble/EUROPEAN%20TOUR/4cbf3639-fd7d-4a55-a5b0-2b503e033a3f.jpg'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Berliner%20Philharmoniker%2C%20Sir%20Simon%20Rattle/Ludwig%20van%20Beethoven%3A%20Symphonies%20Nos.%201-9/71e4514d-8ad0-481b-98d5-718c9d9eb6e2.jpg'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Daniil%20Trifonov/Transcendental%3A%20Daniil%20Trifonov%20plays%20Franz%20Liszt/a0722166-f78d-412b-829f-d985256b005d.jpg'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Duke%20Ellington%20and%20His%20Orchestra/Ellington%20Indigos/04f08670-5932-4de0-a72a-169642300ab0.jpg'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Peter%20Gabriel/Shaking%20The%20Tree%20(Sixteen%20Golden%20Greats)/64d80181-4cb4-4d8c-b280-55121aed1b4f.jpg'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pink%20Floyd/Echoes%3A%20The%20Best%20Of%20Pink%20Floyd/c3ce2faa-273a-4512-9d8d-fd358f8cd66c.png'
Apr 06 10:52:07 opera volumio[13601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/James%20Blake/James%20Blake/95d2ce44-26b4-4a58-8537-57a0f499a0e1.jpg'
Apr 06 10:52:09 opera volumio[13601]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 06 10:52:09 opera volumio[13601]: { Error: connect ECONNREFUSED 157.240.12.36:443
Apr 06 10:52:09 opera volumio[13601]: at Object._errnoException (util.js:1022:11)
Apr 06 10:52:09 opera volumio[13601]: at _exceptionWithHostPort (util.js:1044:20)
Apr 06 10:52:09 opera volumio[13601]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Apr 06 10:52:09 opera volumio[13601]: code: 'ECONNREFUSED',
Apr 06 10:52:09 opera volumio[13601]: errno: 'ECONNREFUSED',
Apr 06 10:52:09 opera volumio[13601]: syscall: 'connect',
Apr 06 10:52:09 opera volumio[13601]: address: '157.240.12.36',
Apr 06 10:52:09 opera volumio[13601]: port: 443 }
Apr 06 10:52:09 opera volumio[13601]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 06 10:52:10 opera sudo[13955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-06 10:51
Apr 06 10:52:10 opera sudo[13955]: 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"