Feb 26 16:01:20 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 26 16:01:22 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 26 16:01:39 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 26 16:01:41 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 26 16:02:06 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 26 16:02:08 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 26 16:02:14 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 26 16:02:15 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Feb 26 16:02:16 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 26 16:02:16 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Feb 26 16:02:16 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Feb 26 16:02:17 volumio systemd[1]: setdatetime-helper.service: Consumed 1.741s CPU time.
Feb 26 16:02:35 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:35 volumio volumio[1169]: info: CorePlayQueue::getTrack 1
Feb 26 16:02:37 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 26 16:02:39 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 26 16:02:40 volumio volumio[1169]: info:
Feb 26 16:02:40 volumio volumio[1169]: ---------------------------- MPD announces system playlist update
Feb 26 16:02:40 volumio volumio[1169]: info: Ignoring MPD Status Update
Feb 26 16:02:40 volumio volumio[1169]: info:
Feb 26 16:02:40 volumio volumio[1169]: ---------------------------- MPD announces state update: player
Feb 26 16:02:40 volumio volumio[1169]: info: ControllerMpd::getState
Feb 26 16:02:40 volumio volumio[1169]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 16:02:40 volumio volumio[1169]: info:
Feb 26 16:02:40 volumio volumio[1169]: ---------------------------- MPD announces system playlist update
Feb 26 16:02:40 volumio volumio[1169]: info: Ignoring MPD Status Update
Feb 26 16:02:40 volumio volumio[1169]: info:
Feb 26 16:02:40 volumio volumio[1169]: ---------------------------- MPD announces state update: player
Feb 26 16:02:40 volumio volumio[1169]: info: ControllerMpd::getState
Feb 26 16:02:40 volumio volumio[1169]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 16:02:40 volumio volumio[1169]: info:
Feb 26 16:02:40 volumio volumio[1169]: ---------------------------- MPD announces system playlist update
Feb 26 16:02:40 volumio volumio[1169]: info: Ignoring MPD Status Update
Feb 26 16:02:40 volumio volumio[1169]: info:
Feb 26 16:02:40 volumio volumio[1169]: ---------------------------- MPD announces state update: player
Feb 26 16:02:40 volumio volumio[1169]: error: updateQueue error: null
Feb 26 16:02:40 volumio volumio[1169]: error: updateQueue error: null
Feb 26 16:02:40 volumio volumio[1169]: info: ControllerMpd::getState
Feb 26 16:02:40 volumio volumio[1169]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 16:02:40 volumio volumio[1169]: info: ------------------------------ 5ms
Feb 26 16:02:40 volumio volumio[1169]: info: sendMpdCommand status took 5 milliseconds
Feb 26 16:02:40 volumio volumio[1169]: info: ------------------------------ 4ms
Feb 26 16:02:40 volumio volumio[1169]: info: sendMpdCommand status took 3 milliseconds
Feb 26 16:02:40 volumio volumio[1169]: verbose: ControllerMpd::parseState
Feb 26 16:02:40 volumio volumio[1169]: verbose: ControllerMpd::parseState
Feb 26 16:02:40 volumio volumio[1169]: info: ControllerMpd::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::servicePushState
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 26 16:02:40 volumio volumio[1169]: verbose: CURRENT POSITION 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::syncState stateService stop
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::syncState currentStatus play
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::stPlaybackTimer
Feb 26 16:02:40 volumio volumio[1169]: info: ControllerMpd::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::servicePushState
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 26 16:02:40 volumio volumio[1169]: verbose: CURRENT POSITION 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::syncState stateService stop
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::syncState currentStatus stop
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio[1169]: info: No code
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.727+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_PLAYING positionMs=212404 volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.728+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_STOPPED positionMs=0 volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.728+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id="mnt/USB/HDD_BOX/Music/Nhac khong loi/Nicolas de Angelis - Le Meilleur de la Guitare(1997) [WAV]/04. Implora (Avec la Participation de d. Modena).wav" title="Implora (Avec la Participation de d. Modena)"
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.728+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id= title=
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.728+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_STOPPED positionMs= volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.728+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_STOPPED positionMs= volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.728+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id="mnt/USB/HDD_BOX/Music/Nhac khong loi/Nicolas de Angelis - Le Meilleur de la Guitare(1997) [WAV]/04. Implora (Avec la Participation de d. Modena).wav" title="Implora (Avec la Participation de d. Modena)"
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.729+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id="mnt/USB/HDD_BOX/Music/Nhac khong loi/Nicolas de Angelis - Le Meilleur de la Guitare(1997) [WAV]/04. Implora (Avec la Participation de d. Modena).wav" title="Implora (Avec la Participation de d. Modena)"
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.730+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_STOPPED positionMs= volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.730+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id="mnt/USB/HDD_BOX/Music/Nhac khong loi/Nicolas de Angelis - Le Meilleur de la Guitare(1997) [WAV]/04. Implora (Avec la Participation de d. Modena).wav" title="Implora (Avec la Participation de d. Modena)"
Feb 26 16:02:40 volumio volumio[1169]: info: ------------------------------ 25ms
Feb 26 16:02:40 volumio volumio[1169]: info: ------------------------------ 23ms
Feb 26 16:02:40 volumio volumio[1169]: error: updateQueue error: null
Feb 26 16:02:40 volumio volumio[1169]: info: ------------------------------ 24ms
Feb 26 16:02:40 volumio volumio[1169]: info: sendMpdCommand status took 23 milliseconds
Feb 26 16:02:40 volumio volumio[1169]: verbose: ControllerMpd::parseState
Feb 26 16:02:40 volumio volumio[1169]: info: ControllerMpd::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::servicePushState
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 26 16:02:40 volumio volumio[1169]: verbose: CURRENT POSITION 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::syncState stateService stop
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::syncState currentStatus stop
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio[1169]: info: No code
Feb 26 16:02:40 volumio volumio[1169]: info: CoreStateMachine::pushState
Feb 26 16:02:40 volumio volumio[1169]: info: CorePlayQueue::getTrack 0
Feb 26 16:02:40 volumio volumio[1169]: info: CoreCommandRouter::volumioPushState
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.743+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_STOPPED positionMs= volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.744+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_STOPPED positionMs= volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.744+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" state=STATUS_STOPPED positionMs= volume=100
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.744+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id="mnt/USB/HDD_BOX/Music/Nhac khong loi/Nicolas de Angelis - Le Meilleur de la Guitare(1997) [WAV]/04. Implora (Avec la Participation de d. Modena).wav" title="Implora (Avec la Participation de d. Modena)"
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.744+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id="mnt/USB/HDD_BOX/Music/Nhac khong loi/Nicolas de Angelis - Le Meilleur de la Guitare(1997) [WAV]/04. Implora (Avec la Participation de d. Modena).wav" title="Implora (Avec la Participation de d. Modena)"
Feb 26 16:02:40 volumio volumio5-onboarding[1578]: time=2026-02-26T16:02:40.744+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.43:46760 @ 0x2c8acc0" id="mnt/USB/HDD_BOX/Music/Nhac khong loi/Nicolas de Angelis - Le Meilleur de la Guitare(1997) [WAV]/04. Implora (Avec la Participation de d. Modena).wav" title="Implora (Avec la Participation de d. Modena)"
Feb 26 16:02:40 volumio volumio[1169]: info: ------------------------------ 38ms
Feb 26 16:02:47 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 26 16:02:51 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 26 16:02:52 volumio volumio[1169]: info: Preload queue cleared
Feb 26 16:02:52 volumio volumio[1169]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 26 16:02:52 volumio volumio[1169]: info: CoreStateMachine::ClearQueue
Feb 26 16:02:52 volumio volumio[1169]: info: CoreStateMachine::stop
Feb 26 16:02:52 volumio volumio[1169]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 26 16:02:52 volumio volumio[1169]: info: CorePlayQueue::clearPlayQueue
Feb 26 16:02:52 volumio volumio[1169]: info: CorePlayQueue::saveQueue
Feb 26 16:02:52 volumio volumio[1169]: info: CoreCommandRouter::volumioPushQueue
Feb 26 16:02:52 volumio volumio[1169]: info: CoreStateMachine::addQueueItems
Feb 26 16:02:52 volumio volumio[1169]: info: CorePlayQueue::addQueueItems
Feb 26 16:02:52 volumio volumio[1169]: info: Preload queue cleared
Feb 26 16:02:52 volumio volumio[1169]: info: Adding Item to queue: music-library/USB/HDD_BOX/Music/Nhac khong loi/Yanni
Feb 26 16:02:52 volumio volumio[1169]: info: Exploding uri music-library/USB/HDD_BOX/Music/Nhac khong loi/Yanni in service mpd
Feb 26 16:02:54 volumio volumio[1169]: info: ALBUMART /albumart?cacheid=819&web=Yanni/Optimystique/extralarge&path=%2Fmnt%2FUSB%2FHDD_BOX%2FMusic%2FNhac%20khong%20loi%2FYanni%2F1984%20-%20Optimystique%20%5BAPE%5D%2FCDImage.cue&metadata=false
Feb 26 16:02:54 volumio volumio[1169]: info: URI /mnt/USB/HDD_BOX/Music/Nhac khong loi/Yanni/1984 - Optimystique [APE]/CDImage.cue
Feb 26 16:02:54 volumio volumio[1169]: info: ALBUMART /albumart?cacheid=819&web=Yanni/Optimystique/extralarge&path=%2Fmnt%2FUSB%2FHDD_BOX%2FMusic%2FNhac%20khong%20loi%2FYanni%2F1984%20-%20Optimystique%20%5BAPE%5D%2FCDImage.cue&metadata=false
Feb 26 16:02:54 volumio volumio[1169]: info: URI /mnt/USB/HDD_BOX/Music/Nhac khong loi/Yanni/1984 - Optimystique [APE]/CDImage.cue
Feb 26 16:02:54 volumio volumio[1169]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 16:02:54 volumio volumio[1169]: Error: Unable to resolve or reject the same promise twice
Feb 26 16:02:54 volumio volumio[1169]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Feb 26 16:02:54 volumio volumio[1169]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21
Feb 26 16:02:54 volumio volumio[1169]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Feb 26 16:02:54 volumio volumio[1169]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Feb 26 16:02:54 volumio volumio[1169]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Feb 26 16:02:54 volumio volumio[1169]: at Socket.emit (node:events:514:28)
Feb 26 16:02:54 volumio volumio[1169]: at addChunk (node:internal/streams/readable:343:12)
Feb 26 16:02:54 volumio volumio[1169]: at readableAddChunk (node:internal/streams/readable:312:11)
Feb 26 16:02:54 volumio volumio[1169]: at Readable.push (node:internal/streams/readable:253:10)
Feb 26 16:02:54 volumio volumio[1169]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Feb 26 16:02:54 volumio volumio[1169]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 16:02:55 volumio sudo[410]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 16:01'
Feb 26 16:02:55 volumio sudo[410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"