Mar 04 21:07:03 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:03 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 88 86 Mar 04 21:07:03 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 88 --> 86 Mar 04 21:07:03 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:03 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:03 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:07 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:07 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 86 86 Mar 04 21:07:07 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 86 --> 86 Mar 04 21:07:07 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:08 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:08 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:12 volumio go-librespot[1591]: time="2026-03-04T21:07:12+02:00" level=trace msg="sent dealer ping" Mar 04 21:07:12 volumio go-librespot[1591]: time="2026-03-04T21:07:12+02:00" level=trace msg="received dealer pong" Mar 04 21:07:13 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:13 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:14 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:14 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 86 86 Mar 04 21:07:14 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 86 --> 86 Mar 04 21:07:14 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:16 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:16 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 86 86 Mar 04 21:07:16 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 86 --> 86 Mar 04 21:07:16 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:18 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:18 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:23 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:23 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:23 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:23 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 87 87 Mar 04 21:07:23 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 87 --> 87 Mar 04 21:07:23 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:27 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:27 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 85 85 Mar 04 21:07:27 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 85 --> 85 Mar 04 21:07:27 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:28 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:28 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:31 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:31 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 87 86 Mar 04 21:07:31 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 87 --> 86 Mar 04 21:07:31 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:32 volumio go-librespot[1591]: time="2026-03-04T21:07:32+02:00" level=trace msg="received accesspoint ping" Mar 04 21:07:32 volumio go-librespot[1591]: time="2026-03-04T21:07:32+02:00" level=trace msg="received accesspoint pong ack" Mar 04 21:07:33 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:33 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:34 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:34 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 85 85 Mar 04 21:07:34 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 85 --> 85 Mar 04 21:07:34 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:38 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:38 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:42 volumio go-librespot[1591]: time="2026-03-04T21:07:42+02:00" level=trace msg="sent dealer ping" Mar 04 21:07:42 volumio go-librespot[1591]: time="2026-03-04T21:07:42+02:00" level=trace msg="received dealer pong" Mar 04 21:07:43 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:43 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:44 volumio volumio[1217]: info: CoreCommandRouter::volumioMoveQueue Mar 04 21:07:44 volumio volumio[1217]: info: CoreStateMachine::moveQueueItem 86 85 Mar 04 21:07:44 volumio volumio[1217]: info: CorePlayQueue::moveQueueItem 86 --> 85 Mar 04 21:07:44 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:07:48 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:48 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:53 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:53 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:07:54 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState Mar 04 21:07:54 volumio volumio[1217]: info: CorePlayQueue::getTrack 79 Mar 04 21:07:58 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:07:58 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:08:03 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:08:03 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:08:06 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 21:08:06 volumio volumio[1217]: info: CURURI: music-library/NAS/Music Mar 04 21:08:06 volumio volumio[1217]: info: Preload queue cleared Mar 04 21:08:08 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:08:08 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:08:09 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 21:08:09 volumio volumio[1217]: info: CURURI: music-library/NAS/Music/Jazz Mar 04 21:08:09 volumio volumio[1217]: info: Preload queue cleared Mar 04 21:08:12 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 04 21:08:12 volumio volumio[1217]: info: CURURI: music-library/NAS/Music/Jazz/Dianne Reeves Mar 04 21:08:12 volumio volumio[1217]: info: Preload queue cleared Mar 04 21:08:12 volumio go-librespot[1591]: time="2026-03-04T21:08:12+02:00" level=trace msg="sent dealer ping" Mar 04 21:08:12 volumio go-librespot[1591]: time="2026-03-04T21:08:12+02:00" level=trace msg="received dealer pong" Mar 04 21:08:13 volumio dbus-daemon[673]: [system] The maximum number of active connections for UID 1000 has been reached (max_connections_per_user=256) Mar 04 21:08:13 volumio volumio[1217]: info: Discovery: Restarting Browsing Mar 04 21:08:15 volumio volumio[1217]: info: Preload queue cleared Mar 04 21:08:15 volumio volumio[1217]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::ClearQueue Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::stop Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::stPlaybackTimer Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::updateTrackBlock Mar 04 21:08:15 volumio volumio[1217]: info: CorePlayQueue::getTrackBlock Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::pushState Mar 04 21:08:15 volumio volumio[1217]: info: CorePlayQueue::getTrack 79 Mar 04 21:08:15 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 21:08:15 volumio volumio[1217]: info: CoreCommandRouter::volumioPushState Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::serviceStop Mar 04 21:08:15 volumio volumio[1217]: info: CorePlayQueue::getTrack 79 Mar 04 21:08:15 volumio volumio[1217]: info: CoreCommandRouter::serviceStop Mar 04 21:08:15 volumio volumio[1217]: info: ControllerMpd::stop Mar 04 21:08:15 volumio volumio[1217]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 21:08:15 volumio volumio[1217]: info: CorePlayQueue::clearPlayQueue Mar 04 21:08:15 volumio volumio[1217]: info: CorePlayQueue::saveQueue Mar 04 21:08:15 volumio volumio[1217]: info: CoreCommandRouter::volumioPushQueue Mar 04 21:08:15 volumio volumio[1217]: info: CoreStateMachine::addQueueItems Mar 04 21:08:15 volumio volumio[1217]: info: CorePlayQueue::addQueueItems Mar 04 21:08:15 volumio volumio[1217]: info: Preload queue cleared Mar 04 21:08:15 volumio volumio[1217]: info: Adding Item to queue: music-library/NAS/Music/Jazz/Dianne Reeves/Bridges 1999 Mar 04 21:08:15 volumio volumio[1217]: info: Exploding uri music-library/NAS/Music/Jazz/Dianne Reeves/Bridges 1999 in service mpd Mar 04 21:08:15 volumio volumio5-onboarding[1526]: time=2026-03-04T21:08:15.070+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.157:58298 @ 0x1c014d0" state=STATUS_STOPPED positionMs=0 volume=83 Mar 04 21:08:15 volumio volumio5-onboarding[1526]: time=2026-03-04T21:08:15.071+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.157:58298 @ 0x1c014d0" id="mnt/NAS/Music/Jazz/Thelonious Monk/Thelonious Alone In San Francisco - 1959-2021 (24-192)/01. Thelonious Monk - Blue Monk.flac" title="1 - Blue Monk" Mar 04 21:08:15 volumio volumio[1217]: SPOTIFY: RECEIVED VOLUMIO VOLUME 83 Mar 04 21:08:15 volumio volumio[1217]: SPOTIFY: SPOTIFY VOLUME 82 Mar 04 21:08:15 volumio volumio[1217]: SPOTIFY: VOLUMIO VOLUME 83 Mar 04 21:08:15 volumio volumio[1217]: SPOTIFY: DELTA VOLUME ENOUGH: false Mar 04 21:08:15 volumio volumio[1217]: info: Mar 04 21:08:15 volumio volumio[1217]: ---------------------------- MPD announces state update: player Mar 04 21:08:15 volumio volumio[1217]: info: ALBUMART /albumart?cacheid=752&web=Dianne%20Reeves/Bridges/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FJazz%2FDianne%20Reeves%2FBridges%201999%2FDianne%20Reeves%20-%20Bridges.cue&metadata=false Mar 04 21:08:15 volumio volumio[1217]: info: URI /mnt/NAS/Music/Jazz/Dianne Reeves/Bridges 1999/Dianne Reeves - Bridges.cue Mar 04 21:08:15 volumio volumio[1217]: info: ALBUMART /albumart?cacheid=752&web=Dianne%20Reeves/Bridges/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FJazz%2FDianne%20Reeves%2FBridges%201999%2FDianne%20Reeves%20-%20Bridges.cue&metadata=false Mar 04 21:08:15 volumio volumio[1217]: info: URI /mnt/NAS/Music/Jazz/Dianne Reeves/Bridges 1999/Dianne Reeves - Bridges.cue Mar 04 21:08:15 volumio volumio[1217]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 21:08:15 volumio volumio[1217]: Error: Unable to resolve or reject the same promise twice Mar 04 21:08:15 volumio volumio[1217]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 04 21:08:15 volumio volumio[1217]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Mar 04 21:08:15 volumio volumio[1217]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 04 21:08:15 volumio volumio[1217]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 04 21:08:15 volumio volumio[1217]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 04 21:08:15 volumio volumio[1217]: at Socket.emit (node:events:514:28) Mar 04 21:08:15 volumio volumio[1217]: at addChunk (node:internal/streams/readable:343:12) Mar 04 21:08:15 volumio volumio[1217]: at readableAddChunk (node:internal/streams/readable:312:11) Mar 04 21:08:15 volumio volumio[1217]: at Readable.push (node:internal/streams/readable:253:10) Mar 04 21:08:15 volumio volumio[1217]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Mar 04 21:08:15 volumio volumio[1217]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 21:08:15 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1 Mar 04 21:08:15 volumio kernel: xhci_hcd 0000:01:00.0: @000000040cd0c930 00000000 00000000 0e000000 02028001 Mar 04 21:08:15 volumio sudo[27260]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-04 21:07' Mar 04 21:08:15 volumio sudo[27260]: 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"