-- Logs begin at Fri 2025-10-17 15:11:24 CST, end at Fri 2025-10-17 15:26:04 CST. --
Oct 17 15:25:05 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioGetState
Oct 17 15:25:05 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 2
Oct 17 15:25:12 v3tb16p03 volumio[1244]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Oct 17 15:25:12 v3tb16p03 volumio[1244]: info: Retrying Login Due to Network Error
Oct 17 15:25:20 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioGetState
Oct 17 15:25:20 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 2
Oct 17 15:25:22 v3tb16p03 volumio[1244]: info: MyVolumio login type: Token
Oct 17 15:25:35 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioGetState
Oct 17 15:25:35 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 2
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 2
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: Prefetching next song
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: DOING PREFETCH IN MPD
Oct 17 15:25:37 v3tb16p03 volumio[1244]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music_Box/02Lover's Romance/Lover's Romance Vol.02/04. Voyage a Venice.ape"
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info:
Oct 17 15:25:37 v3tb16p03 volumio[1244]: ---------------------------- MPD announces system playlist update
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: Ignoring MPD Status Update
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: sendMpdCommand add "NAS/Music_Box/02Lover's Romance/Lover's Romance Vol.02/04. Voyage a Venice.ape" took 8 milliseconds
Oct 17 15:25:37 v3tb16p03 volumio[1244]: verbose: ControllerMpd::sendMpdCommand consume 1
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: ------------------------------ 11ms
Oct 17 15:25:37 v3tb16p03 volumio[1244]: info: sendMpdCommand consume 1 took 7 milliseconds
Oct 17 15:25:42 v3tb16p03 volumio[1244]: info: CoreStateMachine::startPlaybackTimer
Oct 17 15:25:42 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:25:42 v3tb16p03 volumio[1244]: info: CoreStateMachine::pushState
Oct 17 15:25:42 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:25:42 v3tb16p03 volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 15:25:42 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioPushState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info:
Oct 17 15:25:43 v3tb16p03 volumio[1244]: ---------------------------- MPD announces system playlist update
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: Ignoring MPD Status Update
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info:
Oct 17 15:25:43 v3tb16p03 volumio[1244]: ---------------------------- MPD announces state update: player
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: ControllerMpd::getState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: verbose: ControllerMpd::sendMpdCommand status
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: ------------------------------ 2ms
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: sendMpdCommand status took 2 milliseconds
Oct 17 15:25:43 v3tb16p03 volumio[1244]: verbose: ControllerMpd::parseState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 17 15:25:43 v3tb16p03 volumio[1244]: verbose: ControllerMpd::parseTrackInfo
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: ControllerMpd::pushState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreCommandRouter::servicePushState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:25:43 v3tb16p03 volumio[1244]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Voyage a Venice","artist":"Denver Music Orchestra","album":"Lover's Romance Vol.2","uri":"NAS/Music_Box/02Lover's Romance/Lover's Romance Vol.02/04. Voyage a Venice.ape","trackType":"ape"}
Oct 17 15:25:43 v3tb16p03 volumio[1244]: verbose: CURRENT POSITION 3
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreStateMachine::syncState stateService play
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreStateMachine::syncState currentStatus play
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: Received an update from plugin. extracting info from payload
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreStateMachine::pushState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioPushState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreStateMachine::pushState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioPushState
Oct 17 15:25:43 v3tb16p03 volumio[1244]: info: ------------------------------ 24ms
Oct 17 15:25:50 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioGetState
Oct 17 15:25:50 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:25:52 v3tb16p03 volumio[1244]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Oct 17 15:25:52 v3tb16p03 volumio[1244]: info: Retrying Login Due to Network Error
Oct 17 15:25:59 v3tb16p03 volumio[1244]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 17 15:25:59 v3tb16p03 volumio[1244]: info: CURURI: music-library/NAS/Music_Box/02Lover's Romance/Lover's Romance Vol.01
Oct 17 15:25:59 v3tb16p03 volumio[1244]: info: Preload queue cleared
Oct 17 15:26:02 v3tb16p03 volumio[1244]: info: MyVolumio login type: Token
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioPause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreStateMachine::pause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreStateMachine::stPlaybackTimer
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreStateMachine::servicePause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreCommandRouter::servicePause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: ControllerMpd::pause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: verbose: ControllerMpd::sendMpdCommand pause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: sendMpdCommand pause took 2 milliseconds
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info:
Oct 17 15:26:03 v3tb16p03 volumio[1244]: ---------------------------- MPD announces state update: player
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: ControllerMpd::getState
Oct 17 15:26:03 v3tb16p03 volumio[1244]: verbose: ControllerMpd::sendMpdCommand status
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: sendMpdCommand status took 1 milliseconds
Oct 17 15:26:03 v3tb16p03 volumio[1244]: verbose: ControllerMpd::parseState
Oct 17 15:26:03 v3tb16p03 volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 17 15:26:03 v3tb16p03 volumio[1244]: verbose: ControllerMpd::parseTrackInfo
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: ControllerMpd::pushState
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreCommandRouter::servicePushState
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:26:03 v3tb16p03 volumio[1244]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20330,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Voyage a Venice","artist":"Denver Music Orchestra","album":"Lover's Romance Vol.2","uri":"NAS/Music_Box/02Lover's Romance/Lover's Romance Vol.02/04. Voyage a Venice.ape","trackType":"ape"}
Oct 17 15:26:03 v3tb16p03 volumio[1244]: verbose: CURRENT POSITION 3
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreStateMachine::syncState stateService pause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreStateMachine::syncState currentStatus pause
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreStateMachine::pushState
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CorePlayQueue::getTrack 3
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreCommandRouter::volumioPushState
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: CoreStateMachine::stPlaybackTimer
Oct 17 15:26:03 v3tb16p03 volumio[1244]: info: ------------------------------ 39ms
Oct 17 15:26:03 v3tb16p03 volumio[1244]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 17 15:26:03 v3tb16p03 volumio[1244]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Object.readdirSync (fs.js:1048:3)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Oct 17 15:26:03 v3tb16p03 volumio[1244]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Oct 17 15:26:03 v3tb16p03 volumio[1244]: errno: -20,
Oct 17 15:26:03 v3tb16p03 volumio[1244]: syscall: 'scandir',
Oct 17 15:26:03 v3tb16p03 volumio[1244]: code: 'ENOTDIR',
Oct 17 15:26:03 v3tb16p03 volumio[1244]: path: '/tmp/peppyrunning'
Oct 17 15:26:03 v3tb16p03 volumio[1244]: }
Oct 17 15:26:03 v3tb16p03 volumio[1244]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 17 15:26:04 v3tb16p03 sudo[5882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-17 15:25
Oct 17 15:26:04 v3tb16p03 sudo[5882]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"