-- Logs begin at Sat 2026-04-04 08:09:08 CST, end at Sat 2026-04-04 08:11:59 CST. --
Apr 04 08:10:00 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 08:10:00 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 08:10:00 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 04 08:10:00 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 04 08:10:00 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 04 08:10:00 volumio volumio[884]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 04 08:10:00 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 08:10:00 volumio jellyfin[1439]: [08:10:00] [INF] [1] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: FFmpeg: /usr/lib/jellyfin-ffmpeg/ffmpeg
Apr 04 08:10:00 volumio jellyfin[1439]: [08:10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: ServerId: b1cfc0d663974d88a7e5ad9e731e53ae
Apr 04 08:10:00 volumio jellyfin[1439]: [08:10:00] [INF] [1] Emby.Server.Implementations.ApplicationHost: Core startup complete
Apr 04 08:10:00 volumio jellyfin[1439]: [08:10:00] [INF] [1] Main: Startup complete 0:00:36.2981901
Apr 04 08:10:02 volumio volumio[884]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Apr 04 08:10:02 volumio volumio[884]: info: Completed starting MyVolumio Plugin
Apr 04 08:10:02 volumio volumio[884]: info: BOOT COMPLETED
Apr 04 08:10:02 volumio volumio[884]: [Metrics] CommandRouter: 46s 791.45ms
Apr 04 08:10:02 volumio volumio[884]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 04 08:10:02 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 08:10:02 volumio volumio[884]: info: VolumeController:: Setting startup Volume 100
Apr 04 08:10:02 volumio volumio[884]: info: VolumeController::SetAlsaVolume100
Apr 04 08:10:02 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 08:10:02 volumio volumio[884]: info: CoreCommandRouter::Close All Modals sent
Apr 04 08:10:02 volumio volumio[884]: info: CoreCommandRouter::Close All Modals sent
Apr 04 08:10:02 volumio volumio[884]: info: CoreStateMachine::pushState
Apr 04 08:10:02 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:10:02 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 08:10:02 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Apr 04 08:10:02 volumio jellyfin[1439]: [08:10:02] [INF] [8] Emby.Server.Implementations.ScheduledTasks.TaskManager: Update Plugins Completed after 0 minute(s) and 4 seconds
Apr 04 08:10:02 volumio volumio[884]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Apr 04 08:10:02 volumio volumio[884]: aplay: main:828: audio open error: Device or resource busy
Apr 04 08:10:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 04 08:10:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 04 08:10:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::volumioPause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::stPlaybackTimer
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::servicePause
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::servicePause
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::pause
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand pause
Apr 04 08:11:58 volumio volumio[884]: info:
Apr 04 08:11:58 volumio volumio[884]: ---------------------------- MPD announces state update: player
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand pause took 3 milliseconds
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::getState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 08:11:58 volumio volumio[884]: info:
Apr 04 08:11:58 volumio volumio[884]: ---------------------------- MPD announces state update: player
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::getState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 08:11:58 volumio volumio[884]: info:
Apr 04 08:11:58 volumio volumio[884]: ---------------------------- MPD announces state update: player
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::getState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 08:11:58 volumio volumio[884]: info:
Apr 04 08:11:58 volumio volumio[884]: ---------------------------- MPD announces state update: player
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::getState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand status took 7 milliseconds
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand status took 6 milliseconds
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand status took 5 milliseconds
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand status took 3 milliseconds
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseState
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 04 08:11:58 volumio volumio[884]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseTrackInfo
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseTrackInfo
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseTrackInfo
Apr 04 08:11:58 volumio volumio[884]: verbose: ControllerMpd::parseTrackInfo
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::servicePushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":135801,"duration":264,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2623 Kbps","isStreaming":false,"title":"一生中最爱","artist":"阿梨粤","album":"《不该用情》","uri":"USB/[24K母盘]阿梨粤《不该用情》玻璃母盘直录 24bit96khz/01 一生中最爱.flac","trackType":"flac"}
Apr 04 08:11:58 volumio volumio[884]: verbose: CURRENT POSITION 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState stateService pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState currentStatus pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::stPlaybackTimer
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::servicePushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":135801,"duration":264,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2623 Kbps","isStreaming":false,"title":"一生中最爱","artist":"阿梨粤","album":"《不该用情》","uri":"USB/[24K母盘]阿梨粤《不该用情》玻璃母盘直录 24bit96khz/01 一生中最爱.flac","trackType":"flac"}
Apr 04 08:11:58 volumio volumio[884]: verbose: CURRENT POSITION 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState stateService pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState currentStatus pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::stPlaybackTimer
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::servicePushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":135801,"duration":264,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2623 Kbps","isStreaming":false,"title":"一生中最爱","artist":"阿梨粤","album":"《不该用情》","uri":"USB/[24K母盘]阿梨粤《不该用情》玻璃母盘直录 24bit96khz/01 一生中最爱.flac","trackType":"flac"}
Apr 04 08:11:58 volumio volumio[884]: verbose: CURRENT POSITION 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState stateService pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState currentStatus pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::stPlaybackTimer
Apr 04 08:11:58 volumio volumio[884]: info: ControllerMpd::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::servicePushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":135801,"duration":264,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2623 Kbps","isStreaming":false,"title":"一生中最爱","artist":"阿梨粤","album":"《不该用情》","uri":"USB/[24K母盘]阿梨粤《不该用情》玻璃母盘直录 24bit96khz/01 一生中最爱.flac","trackType":"flac"}
Apr 04 08:11:58 volumio volumio[884]: verbose: CURRENT POSITION 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState stateService pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::syncState currentStatus pause
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::pushState
Apr 04 08:11:58 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Apr 04 08:11:58 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Apr 04 08:11:58 volumio volumio[884]: info: CoreStateMachine::stPlaybackTimer
Apr 04 08:11:58 volumio volumio[884]: info: ------------------------------ 77ms
Apr 04 08:11:58 volumio volumio[884]: info: ------------------------------ 76ms
Apr 04 08:11:58 volumio volumio[884]: info: ------------------------------ 75ms
Apr 04 08:11:58 volumio volumio[884]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 08:11:58 volumio volumio[884]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Apr 04 08:11:58 volumio volumio[884]: at Object.readdirSync (fs.js:1048:3)
Apr 04 08:11:58 volumio volumio[884]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Apr 04 08:11:58 volumio volumio[884]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Apr 04 08:11:58 volumio volumio[884]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Apr 04 08:11:58 volumio volumio[884]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Apr 04 08:11:58 volumio volumio[884]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Apr 04 08:11:58 volumio volumio[884]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Apr 04 08:11:58 volumio volumio[884]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Apr 04 08:11:58 volumio volumio[884]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Apr 04 08:11:58 volumio volumio[884]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Apr 04 08:11:58 volumio volumio[884]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Apr 04 08:11:58 volumio volumio[884]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Apr 04 08:11:58 volumio volumio[884]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Apr 04 08:11:58 volumio volumio[884]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Apr 04 08:11:58 volumio volumio[884]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Apr 04 08:11:58 volumio volumio[884]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Apr 04 08:11:58 volumio volumio[884]: errno: -20,
Apr 04 08:11:58 volumio volumio[884]: syscall: 'scandir',
Apr 04 08:11:58 volumio volumio[884]: code: 'ENOTDIR',
Apr 04 08:11:58 volumio volumio[884]: path: '/tmp/peppyrunning'
Apr 04 08:11:58 volumio volumio[884]: }
Apr 04 08:11:58 volumio volumio[884]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 08:11:59 volumio sudo[2557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-04 08:10
Apr 04 08:11:59 volumio sudo[2557]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST"
VOLUMIO_VERSION="3.757"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"