-- Logs begin at Fri 2025-04-18 15:03:10 UTC, end at Fri 2025-04-18 15:10:03 UTC. -- Apr 18 15:09:00 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:04 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:08 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:12 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:16 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:20 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:21 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 18 15:09:21 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand update Apr 18 15:09:21 volumio volumio[881]: info: sendMpdCommand update took 2 milliseconds Apr 18 15:09:21 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:21 volumio volumio[881]: info: Apr 18 15:09:21 volumio volumio[881]: ---------------------------- MPD announces state update: update Apr 18 15:09:21 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:21 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:21 volumio volumio[881]: info: sendMpdCommand status took 2 milliseconds Apr 18 15:09:21 volumio volumio[881]: info: sendMpdCommand status took 2 milliseconds Apr 18 15:09:21 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:21 volumio volumio[881]: info: Command Router : Notfying DB Updatetrue Apr 18 15:09:21 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:21 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:21 volumio volumio[881]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 18 15:09:21 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:21 volumio volumio[881]: info: ControllerMpd::pushState Apr 18 15:09:21 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 18 15:09:21 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:21 volumio volumio[881]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":253,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"眠れる雨音 -自然音-","artist":"リラックスヒーリングサウンド","album":"雨の音 -睡眠、読書のための1/fゆらぎ-","uri":"USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac","trackType":"flac"} Apr 18 15:09:21 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 18 15:09:21 volumio volumio[881]: info: CoreStateMachine::syncState stateService pause Apr 18 15:09:21 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus stop Apr 18 15:09:21 volumio volumio[881]: info: CoreStateMachine::pushState Apr 18 15:09:21 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:21 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 18 15:09:21 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 15:09:21 volumio volumio[881]: info: ------------------------------ 71ms Apr 18 15:09:24 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:24 volumio volumio[881]: info: CoreCommandRouter::Close All Modals sent Apr 18 15:09:26 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:26 volumio volumio[881]: info: Apr 18 15:09:26 volumio volumio[881]: ---------------------------- MPD announces state update: update Apr 18 15:09:26 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:26 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:26 volumio volumio[881]: info: sendMpdCommand status took 2 milliseconds Apr 18 15:09:26 volumio volumio[881]: info: sendMpdCommand status took 1 milliseconds Apr 18 15:09:26 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:26 volumio volumio[881]: info: Command Router : Notfying DB Updatefalse Apr 18 15:09:26 volumio volumio[881]: info: CoreCommandRouter::Close All Modals sent Apr 18 15:09:26 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:26 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:26 volumio volumio[881]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 18 15:09:26 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:26 volumio volumio[881]: info: ControllerMpd::pushState Apr 18 15:09:26 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 18 15:09:26 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:26 volumio volumio[881]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":253,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"眠れる雨音 -自然音-","artist":"リラックスヒーリングサウンド","album":"雨の音 -睡眠、読書のための1/fゆらぎ-","uri":"USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac","trackType":"flac"} Apr 18 15:09:26 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 18 15:09:26 volumio volumio[881]: info: CoreStateMachine::syncState stateService pause Apr 18 15:09:26 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus stop Apr 18 15:09:26 volumio volumio[881]: info: CoreStateMachine::pushState Apr 18 15:09:26 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:26 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 18 15:09:26 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 15:09:26 volumio volumio[881]: info: ------------------------------ 38ms Apr 18 15:09:28 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:29 volumio volumio[881]: info: CoreCommandRouter::volumioPlay Apr 18 15:09:29 volumio volumio[881]: verbose: UNSET VOLATILE Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::play index undefined Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 15:09:29 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::startPlaybackTimer Apr 18 15:09:29 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::clearAddPlayTracks USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 15:09:29 volumio volumio[881]: info: Apr 18 15:09:29 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand stop took 4 milliseconds Apr 18 15:09:29 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 15:09:29 volumio volumio[881]: info: Apr 18 15:09:29 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 18 15:09:29 volumio volumio[881]: info: Ignoring MPD Status Update Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand status took 10 milliseconds Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand clear took 12 milliseconds Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand add "USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac" Apr 18 15:09:29 volumio volumio[881]: error: updateQueue error: null Apr 18 15:09:29 volumio volumio[881]: info: Apr 18 15:09:29 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 18 15:09:29 volumio volumio[881]: info: Ignoring MPD Status Update Apr 18 15:09:29 volumio volumio[881]: info: ------------------------------ 15ms Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand add "USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac" took 7 milliseconds Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand play Apr 18 15:09:29 volumio volumio[881]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 18 15:09:29 volumio volumio[881]: info: ------------------------------ 29ms Apr 18 15:09:29 volumio volumio[881]: info: ------------------------------ 11ms Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand play took 6 milliseconds Apr 18 15:09:29 volumio volumio[881]: info: Apr 18 15:09:29 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 18 15:09:29 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:29 volumio kernel: usb 1-1.4: uac_clock_source_is_valid(): cannot get clock validity for id 5 Apr 18 15:09:29 volumio kernel: usb 1-1.4: clock source 5 is not valid, cannot use Apr 18 15:09:29 volumio volumio[881]: info: Apr 18 15:09:29 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand status took 11 milliseconds Apr 18 15:09:29 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand clearerror took 6 milliseconds Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand status took 6 milliseconds Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:29 volumio volumio[881]: info: ControllerMpd::pushState Apr 18 15:09:29 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 18 15:09:29 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:29 volumio volumio[881]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":253,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"眠れる雨音 -自然音-","artist":"リラックスヒーリングサウンド","album":"雨の音 -睡眠、読書のための1/fゆらぎ-","uri":"USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac","trackType":"flac"} Apr 18 15:09:29 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::syncState stateService pause Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus stop Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::pushState Apr 18 15:09:29 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:29 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 18 15:09:29 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 15:09:29 volumio volumio[881]: info: ------------------------------ 30ms Apr 18 15:09:29 volumio volumio[881]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 18 15:09:29 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:29 volumio volumio[881]: info: ControllerMpd::pushState Apr 18 15:09:29 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 18 15:09:29 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:29 volumio volumio[881]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":253,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"眠れる雨音 -自然音-","artist":"リラックスヒーリングサウンド","album":"雨の音 -睡眠、読書のための1/fゆらぎ-","uri":"USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac","trackType":"flac"} Apr 18 15:09:29 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::syncState stateService pause Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus stop Apr 18 15:09:29 volumio volumio[881]: info: CoreStateMachine::pushState Apr 18 15:09:29 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:29 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 18 15:09:29 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 15:09:29 volumio volumio[881]: info: ------------------------------ 33ms Apr 18 15:09:30 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 18 15:09:31 volumio smbd[2293]: [2025/04/18 15:09:31.988843, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 18 15:09:31 volumio smbd[2293]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 18 15:09:31 volumio smbd[2293]: [2025/04/18 15:09:31.990604, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 18 15:09:31 volumio smbd[2293]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 18 15:09:31 volumio smbd[2293]: [2025/04/18 15:09:31.990806, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 18 15:09:31 volumio smbd[2293]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 18 15:09:32 volumio smbd[2293]: [2025/04/18 15:09:32.002454, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 18 15:09:32 volumio smbd[2293]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 18 15:09:32 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::volumioPlay Apr 18 15:09:36 volumio volumio[881]: verbose: UNSET VOLATILE Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::play index undefined Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 18 15:09:36 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::startPlaybackTimer Apr 18 15:09:36 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::clearAddPlayTracks USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand stop Apr 18 15:09:36 volumio volumio[881]: info: Apr 18 15:09:36 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand stop took 5 milliseconds Apr 18 15:09:36 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand clear Apr 18 15:09:36 volumio volumio[881]: info: Apr 18 15:09:36 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 18 15:09:36 volumio volumio[881]: info: Ignoring MPD Status Update Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand status took 2 milliseconds Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand clear took 2 milliseconds Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand add "USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac" Apr 18 15:09:36 volumio volumio[881]: error: updateQueue error: null Apr 18 15:09:36 volumio volumio[881]: info: Apr 18 15:09:36 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 18 15:09:36 volumio volumio[881]: info: Ignoring MPD Status Update Apr 18 15:09:36 volumio volumio[881]: info: ------------------------------ 4ms Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand add "USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac" took 3 milliseconds Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand play Apr 18 15:09:36 volumio volumio[881]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 18 15:09:36 volumio volumio[881]: info: ------------------------------ 16ms Apr 18 15:09:36 volumio volumio[881]: info: ------------------------------ 14ms Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand play took 13 milliseconds Apr 18 15:09:36 volumio volumio[881]: info: Apr 18 15:09:36 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 18 15:09:36 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:36 volumio kernel: usb 1-1.4: uac_clock_source_is_valid(): cannot get clock validity for id 5 Apr 18 15:09:36 volumio kernel: usb 1-1.4: clock source 5 is not valid, cannot use Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand status took 7 milliseconds Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:36 volumio volumio[881]: info: Apr 18 15:09:36 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 18 15:09:36 volumio volumio[881]: info: ControllerMpd::getState Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand clearerror took 5 milliseconds Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:36 volumio volumio[881]: info: ControllerMpd::pushState Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 18 15:09:36 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:36 volumio volumio[881]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":253,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"眠れる雨音 -自然音-","artist":"リラックスヒーリングサウンド","album":"雨の音 -睡眠、読書のための1/fゆらぎ-","uri":"USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac","trackType":"flac"} Apr 18 15:09:36 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::syncState stateService pause Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus stop Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::pushState Apr 18 15:09:36 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 15:09:36 volumio volumio[881]: info: ------------------------------ 32ms Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand status took 21 milliseconds Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 18 15:09:36 volumio volumio[881]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 18 15:09:36 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 18 15:09:36 volumio volumio[881]: info: ControllerMpd::pushState Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 18 15:09:36 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:36 volumio volumio[881]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":253,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"眠れる雨音 -自然音-","artist":"リラックスヒーリングサウンド","album":"雨の音 -睡眠、読書のための1/fゆらぎ-","uri":"USB/122882A228828487/$RECYCLE.BIN/S-1-5-21-3531676007-1707676650-4027905595-1000/$RG06YKF/001-眠れる雨音 -自然音-.flac","trackType":"flac"} Apr 18 15:09:36 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::syncState stateService pause Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus stop Apr 18 15:09:36 volumio volumio[881]: info: CoreStateMachine::pushState Apr 18 15:09:36 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 18 15:09:36 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 15:09:36 volumio volumio[881]: info: ------------------------------ 38ms Apr 18 15:09:40 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:44 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 18 15:09:50 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 18 15:10:03 volumio volumio[881]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 15:10:03 volumio volumio[881]: { Error: connect ETIMEDOUT 199.16.156.7:80 Apr 18 15:10:03 volumio volumio[881]: at Object._errnoException (util.js:1022:11) Apr 18 15:10:03 volumio volumio[881]: at _exceptionWithHostPort (util.js:1044:20) Apr 18 15:10:03 volumio volumio[881]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 18 15:10:03 volumio volumio[881]: code: 'ETIMEDOUT', Apr 18 15:10:03 volumio volumio[881]: errno: 'ETIMEDOUT', Apr 18 15:10:03 volumio volumio[881]: syscall: 'connect', Apr 18 15:10:03 volumio volumio[881]: address: '199.16.156.7', Apr 18 15:10:03 volumio volumio[881]: port: 80 } Apr 18 15:10:03 volumio volumio[881]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 15:10:03 volumio sudo[2371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-18 15:09 Apr 18 15:10:03 volumio sudo[2371]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"