-- Logs begin at Mon 2024-11-25 08:06:54 JST, end at Mon 2024-11-25 09:10:34 JST. -- Nov 25 09:09:08 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 09:09:08 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:12 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 09:09:12 volumioras-pi-3-pcm5102adual volumio[7439]: info: Getting webradio selection Nov 25 09:09:12 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:21 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 09:09:21 volumioras-pi-3-pcm5102adual volumio[7439]: info: TuneIn handleBrowseUri: tunein/location Nov 25 09:09:21 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:23 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 09:09:23 volumioras-pi-3-pcm5102adual volumio[7439]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101216 Nov 25 09:09:23 volumioras-pi-3-pcm5102adual volumio[7439]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101216 Nov 25 09:09:23 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:25 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 09:09:25 volumioras-pi-3-pcm5102adual volumio[7439]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101255 Nov 25 09:09:25 volumioras-pi-3-pcm5102adual volumio[7439]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101255 Nov 25 09:09:25 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:28 volumioras-pi-3-pcm5102adual ntpd[853]: 122.215.240.52 local addr 192.168.116.190 -> Nov 25 09:09:54 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 09:09:54 volumioras-pi-3-pcm5102adual volumio[7439]: info: TuneIn handleBrowseUri: tunein/browse/?id=r100932 Nov 25 09:09:54 volumioras-pi-3-pcm5102adual volumio[7439]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r100932 Nov 25 09:09:54 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:54 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:56 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 09:09:56 volumioras-pi-3-pcm5102adual volumio[7439]: info: TuneIn handleBrowseUri: tunein/browse/?id=r100932&filter=g154 Nov 25 09:09:56 volumioras-pi-3-pcm5102adual volumio[7439]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r100932&filter=g154 Nov 25 09:09:56 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:57 volumioras-pi-3-pcm5102adual volumiologrotate[694]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO_RAS': No such file or directory Nov 25 09:09:57 volumioras-pi-3-pcm5102adual volumiologrotate[694]: ls: cannot access 'PI': No such file or directory Nov 25 09:09:57 volumioras-pi-3-pcm5102adual volumiologrotate[694]: ls: cannot access '3': No such file or directory Nov 25 09:09:57 volumioras-pi-3-pcm5102adual volumiologrotate[694]: ls: cannot access 'PCM5102A_DUAL': No such file or directory Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::ClearQueue Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::stop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::stPlaybackTimer Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::updateTrackBlock Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrackBlock Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::serviceStop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::serviceStop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::stop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand stop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::clearPlayQueue Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::saveQueue Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushQueue Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::addQueueItems Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::addQueueItems Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s299418&filter=g154 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces state update: player Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand stop took 30 milliseconds Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::getState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand status Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces state update: player Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::getState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand status Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand status took 4 milliseconds Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand status took 3 milliseconds Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseTrackInfo Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseTrackInfo Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::servicePushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Israel","artist":"Bill Evans","album":"Montreux II","uri":"USB/A_64GB/Bill Evans - Montreux II (1970) [2013_FLAC 24-88,2]/05. Israel.flac","trackType":"flac"} Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: CURRENT POSITION 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState stateService stop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState currentStatus stop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: No code Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::servicePushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Israel","artist":"Bill Evans","album":"Montreux II","uri":"USB/A_64GB/Bill Evans - Montreux II (1970) [2013_FLAC 24-88,2]/05. Israel.flac","trackType":"flac"} Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: CURRENT POSITION 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState stateService stop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState currentStatus stop Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: No code Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 9 Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 66ms Nov 25 09:09:58 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 65ms Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushQueue Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::saveQueue Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::updateTrackBlock Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrackBlock Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPlay Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::play index 0 Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::stop Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::play index undefined Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 0 Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::startPlaybackTimer Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 0 Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: [1732493399088] ControllerWebradio::clearAddPlayTrack Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand stop Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand stop took 3 milliseconds Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand clear Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces system playlist update Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: Ignoring MPD Status Update Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand clear took 1 milliseconds Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand load "http://titan.shoutca.st:8790/" Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces system playlist update Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: Ignoring MPD Status Update Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: error: updateQueue error: null Nov 25 09:09:59 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 5ms Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand add "http://titan.shoutca.st:8790/" Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: error: updateQueue error: null Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces system playlist update Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: Ignoring MPD Status Update Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 5837ms Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand add "http://titan.shoutca.st:8790/" took 3 milliseconds Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand play Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces system playlist update Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: Ignoring MPD Status Update Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 6ms Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand play took 3 milliseconds Nov 25 09:10:04 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 2ms Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces state update: player Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::getState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand status Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: ---------------------------- MPD announces state update: player Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::getState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand status Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand clearerror Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand status took 9 milliseconds Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand clearerror Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand status took 14 milliseconds Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand clearerror took 8 milliseconds Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseTrackInfo Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::servicePushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 0 Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"} Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: CURRENT POSITION 0 Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState stateService stop Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState currentStatus stop Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: No code Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 51ms Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand clearerror took 40 milliseconds Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: sendMpdCommand playlistinfo took 39 milliseconds Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: ControllerMpd::parseTrackInfo Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: ControllerMpd::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::servicePushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::getTrack 0 Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://titan.shoutca.st:8790/","trackType":"st:8790/"} Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: verbose: CURRENT POSITION 0 Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState stateService stop Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::syncState currentStatus stop Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: No code Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::pushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushState Nov 25 09:10:05 volumioras-pi-3-pcm5102adual volumio[7439]: info: ------------------------------ 81ms Nov 25 09:10:09 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 25 09:10:09 volumioras-pi-3-pcm5102adual volumio[7439]: info: CURURI: music-library Nov 25 09:10:09 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:10:10 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 25 09:10:10 volumioras-pi-3-pcm5102adual volumio[7439]: info: CURURI: music-library/USB Nov 25 09:10:10 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::ClearQueue Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::stop Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::clearPlayQueue Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::saveQueue Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::volumioPushQueue Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreStateMachine::addQueueItems Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: CorePlayQueue::addQueueItems Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: Preload queue cleared Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: Adding Item to queue: music-library/USB/240GB_SSD Nov 25 09:10:30 volumioras-pi-3-pcm5102adual volumio[7439]: info: Exploding uri music-library/USB/240GB_SSD in service mpd Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: CURURI: music-library/USB/240GB_SSD Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: ALBUMART /albumart?cacheid=626&web=//extralarge&path=%2Fmnt%2FUSB%2F240GB_SSD%2F%24%24%24%20Wav%E3%83%95%E3%82%A1%E3%82%A4%E3%83%AB%E3%80%80%E6%A9%8B%E6%9C%AC%E6%8A%80%E8%A1%93%E7%A0%94%E7%A9%B6%E6%89%80%2Fsine_-06_30_01000%2Fimpulse_-06_15.wav&metadata=false Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: URI /mnt/USB/240GB_SSD/$$$ Wavファイル　橋本技術研究所/sine_-06_30_01000/impulse_-06_15.wav Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: ALBUMART /albumart?cacheid=626&web=//extralarge&path=%2Fmnt%2FUSB%2F240GB_SSD%2F%24%24%24%20Wav%E3%83%95%E3%82%A1%E3%82%A4%E3%83%AB%E3%80%80%E6%A9%8B%E6%9C%AC%E6%8A%80%E8%A1%93%E7%A0%94%E7%A9%B6%E6%89%80%2Fsine_-06_30_01000%2Fpink_-06_30.wav&metadata=false Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: URI /mnt/USB/240GB_SSD/$$$ Wavファイル　橋本技術研究所/sine_-06_30_01000/pink_-06_30.wav Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: ALBUMART /albumart?cacheid=626&web=//extralarge&path=%2Fmnt%2FUSB%2F240GB_SSD%2F%24%24%24%20Wav%E3%83%95%E3%82%A1%E3%82%A4%E3%83%AB%E3%80%80%E6%A9%8B%E6%9C%AC%E6%8A%80%E8%A1%93%E7%A0%94%E7%A9%B6%E6%89%80%2Fsine_-06_30_01000%2Fsine_-06_30_01000.wav&metadata=false Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: URI /mnt/USB/240GB_SSD/$$$ Wavファイル　橋本技術研究所/sine_-06_30_01000/sine_-06_30_01000.wav Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: ALBUMART /albumart?cacheid=626&web=//extralarge&path=%2Fmnt%2FUSB%2F240GB_SSD%2F%24%24%24%20Wav%E3%83%95%E3%82%A1%E3%82%A4%E3%83%AB%E3%80%80%E6%A9%8B%E6%9C%AC%E6%8A%80%E8%A1%93%E7%A0%94%E7%A9%B6%E6%89%80%2Fsine_-06_30_01000%2Fsine_-06_30_01000.zip&metadata=false Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: URI /mnt/USB/240GB_SSD/$$$ Wavファイル　橋本技術研究所/sine_-06_30_01000/sine_-06_30_01000.zip Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: ALBUMART /albumart?cacheid=626&web=//extralarge&path=%2Fmnt%2FUSB%2F240GB_SSD%2F%24%24%24%20Wav%E3%83%95%E3%82%A1%E3%82%A4%E3%83%AB%E3%80%80%E6%A9%8B%E6%9C%AC%E6%8A%80%E8%A1%93%E7%A0%94%E7%A9%B6%E6%89%80%2Fsine_-06_30_01000%2Fsine_-06_30_01000.zip&metadata=false Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: info: URI /mnt/USB/240GB_SSD/$$$ Wavファイル　橋本技術研究所/sine_-06_30_01000/sine_-06_30_01000.zip Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: Error: Unable to resolve or reject the same promise twice Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at Socket.emit (events.js:315:20) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at addChunk (internal/streams/readable.js:309:12) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at readableAddChunk (internal/streams/readable.js:280:11) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at Socket.Readable.push (internal/streams/readable.js:223:10) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Nov 25 09:10:33 volumioras-pi-3-pcm5102adual volumio[7439]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 09:10:34 volumioras-pi-3-pcm5102adual kernel: hwmon hwmon1: Undervoltage detected! Nov 25 09:10:34 volumioras-pi-3-pcm5102adual sudo[8824]: volumio : unable to resolve host volumioras-pi-3-pcm5102adual Nov 25 09:10:34 volumioras-pi-3-pcm5102adual sudo[8824]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Nov 25 09:10:34 volumioras-pi-3-pcm5102adual sudo[8824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 09:09 Nov 25 09:10:34 volumioras-pi-3-pcm5102adual sudo[8824]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"