-- Logs begin at Fri 2025-12-05 22:36:29 CST, end at Fri 2025-12-05 22:55:46 CST. -- Dec 05 22:54:36 volumio kernel: usb 3-1: USB disconnect, device number 3 Dec 05 22:54:36 volumio volumio[1167]: info: Dec 05 22:54:36 volumio volumio[1167]: ---------------------------- MPD announces state update: player Dec 05 22:54:36 volumio volumio[1167]: info: ControllerMpd::getState Dec 05 22:54:36 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:54:36 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 05 22:54:36 volumio volumio[1167]: info: sendMpdCommand status took 3 milliseconds Dec 05 22:54:36 volumio volumio[1167]: verbose: ControllerMpd::parseState Dec 05 22:54:36 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:54:36 volumio volumio[1167]: info: sendMpdCommand clearerror took 2 milliseconds Dec 05 22:54:36 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 05 22:54:36 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:54:36 volumio volumio[1167]: info: ControllerMpd::pushState Dec 05 22:54:36 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Dec 05 22:54:36 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Dec 05 22:54:36 volumio volumio[1167]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":267141,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"807 Kbps","isStreaming":false,"title":"01. 梦里水乡.flac","artist":null,"album":null,"uri":"NAS/MyMusic/无损/周/周虹-2011-精选典雅-[16Bit44.1kHz]/01. 梦里水乡.flac","trackType":"flac"} Dec 05 22:54:36 volumio volumio[1167]: verbose: CURRENT POSITION 0 Dec 05 22:54:36 volumio volumio[1167]: info: CoreStateMachine::syncState stateService pause Dec 05 22:54:36 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Dec 05 22:54:36 volumio volumio[1167]: info: CoreStateMachine::pushState Dec 05 22:54:36 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Dec 05 22:54:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:54:36 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Dec 05 22:54:36 volumio volumio[1167]: info: ------------------------------ 10ms Dec 05 22:54:36 volumio volumio[1167]: info: Dec 05 22:54:36 volumio volumio[1167]: ---------------------------- USB Audio Device Detached Dec 05 22:54:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 05 22:54:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 22:54:36 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Dec 05 22:54:51 volumio ntpd[1149]: receive: Unexpected origin timestamp 0xecdd70bb.856d309f does not match aorg 0000000000.00000000 from server@193.182.111.12 xmt 0xecdd70bb.a3efefa7 Dec 05 22:55:02 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Dec 05 22:55:02 volumio volumio[1167]: info: CorePlayQueue::getTrack 1 Dec 05 22:55:02 volumio volumio[1167]: info: Prefetching next song Dec 05 22:55:02 volumio volumio[1167]: info: DOING PREFETCH IN MPD Dec 05 22:55:02 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyMusic/无损/周/周虹-2011-精选典雅-[16Bit44.1kHz]/02. 当爱情经过的时候.flac" Dec 05 22:55:02 volumio volumio[1167]: info: Dec 05 22:55:02 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Dec 05 22:55:02 volumio volumio[1167]: info: Ignoring MPD Status Update Dec 05 22:55:02 volumio volumio[1167]: info: sendMpdCommand add "NAS/MyMusic/无损/周/周虹-2011-精选典雅-[16Bit44.1kHz]/02. 当爱情经过的时候.flac" took 1 milliseconds Dec 05 22:55:02 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 05 22:55:02 volumio volumio[1167]: info: Dec 05 22:55:02 volumio volumio[1167]: ---------------------------- MPD announces state update: options Dec 05 22:55:02 volumio volumio[1167]: info: ------------------------------ 1ms Dec 05 22:55:02 volumio volumio[1167]: info: sendMpdCommand consume 1 took 0 milliseconds Dec 05 22:55:02 volumio volumio[1167]: info: ControllerMpd::getState Dec 05 22:55:02 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Dec 05 22:55:02 volumio volumio[1167]: info: sendMpdCommand status took 0 milliseconds Dec 05 22:55:02 volumio volumio[1167]: verbose: ControllerMpd::parseState Dec 05 22:55:02 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 05 22:55:02 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 0 milliseconds Dec 05 22:55:02 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Dec 05 22:55:02 volumio volumio[1167]: info: ControllerMpd::pushState Dec 05 22:55:02 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Dec 05 22:55:02 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Dec 05 22:55:02 volumio volumio[1167]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":267141,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"807 Kbps","isStreaming":false,"title":"01. 梦里水乡.flac","artist":null,"album":null,"uri":"NAS/MyMusic/无损/周/周虹-2011-精选典雅-[16Bit44.1kHz]/01. 梦里水乡.flac","trackType":"flac"} Dec 05 22:55:02 volumio volumio[1167]: verbose: CURRENT POSITION 0 Dec 05 22:55:02 volumio volumio[1167]: info: CoreStateMachine::syncState stateService pause Dec 05 22:55:02 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Dec 05 22:55:02 volumio volumio[1167]: info: CoreStateMachine::pushState Dec 05 22:55:02 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Dec 05 22:55:02 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:55:02 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Dec 05 22:55:02 volumio volumio[1167]: info: ------------------------------ 6ms Dec 05 22:55:07 volumio volumio[1167]: info: CoreStateMachine::startPlaybackTimer Dec 05 22:55:07 volumio volumio[1167]: info: CorePlayQueue::getTrack 1 Dec 05 22:55:07 volumio volumio[1167]: info: CoreStateMachine::pushState Dec 05 22:55:07 volumio volumio[1167]: info: CorePlayQueue::getTrack 1 Dec 05 22:55:07 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:55:07 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Dec 05 22:55:46 volumio kernel: usb 3-1: new full-speed USB device number 4 using xhci_hcd Dec 05 22:55:46 volumio kernel: usb 3-1: New USB device found, idVendor=08bb, idProduct=2706, bcdDevice= 1.00 Dec 05 22:55:46 volumio kernel: usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Dec 05 22:55:46 volumio kernel: usb 3-1: Product: USB Audio DAC Dec 05 22:55:46 volumio kernel: usb 3-1: Manufacturer: Burr-Brown from TI Dec 05 22:55:46 volumio kernel: input: Burr-Brown from TI USB Audio DAC as /devices/pci0000:00/0000:00:1b.0/0000:01:00.0/usb3/3-1/3-1:1.2/0003:08BB:2706.0008/input/input31 Dec 05 22:55:46 volumio kernel: hid-generic 0003:08BB:2706.0008: input,hidraw4: USB HID v1.00 Device [Burr-Brown from TI USB Audio DAC ] on usb-0000:01:00.0-1/input2 Dec 05 22:55:46 volumio volumio[1167]: info: Dec 05 22:55:46 volumio volumio[1167]: ---------------------------- USB Audio Device Attached Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::Close All Modals sent Dec 05 22:55:46 volumio volumio[1167]: info: Preparing to save Alsa Options, stopping services first Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Dec 05 22:55:46 volumio volumio[1167]: info: CorePlayQueue::getTrack 1 Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::volumioPause Dec 05 22:55:46 volumio volumio[1167]: info: CoreStateMachine::pause Dec 05 22:55:46 volumio volumio[1167]: info: CoreStateMachine::stPlaybackTimer Dec 05 22:55:46 volumio volumio[1167]: info: CoreStateMachine::servicePause Dec 05 22:55:46 volumio volumio[1167]: info: CorePlayQueue::getTrack 1 Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::servicePause Dec 05 22:55:46 volumio volumio[1167]: info: ControllerMpd::pause Dec 05 22:55:46 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand pause Dec 05 22:55:46 volumio volumio[1167]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"USB Audio DAC","alsacard":"DAC"},"i2s":false} Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 22:55:46 volumio systemd-udevd[7431]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 05 22:55:46 volumio volumio[1167]: info: Setting default mixerSoftMaster for Softvolume device Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 05 22:55:46 volumio volumio[1167]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 05 22:55:46 volumio volumio[1167]: info: Disabling external Volume Control Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 22:55:46 volumio volumio[1167]: info: Enable softmixer device for audio device undefined Dec 05 22:55:46 volumio volumio[1167]: info: CoreStateMachine::pushState Dec 05 22:55:46 volumio volumio[1167]: info: CorePlayQueue::getTrack 1 Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 22:55:46 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Dec 05 22:55:46 volumio volumio[1167]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 22:55:46 volumio volumio[1167]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Dec 05 22:55:46 volumio volumio[1167]: at Object.readdirSync (fs.js:1048:3) Dec 05 22:55:46 volumio volumio[1167]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Dec 05 22:55:46 volumio volumio[1167]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Dec 05 22:55:46 volumio volumio[1167]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Dec 05 22:55:46 volumio volumio[1167]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Dec 05 22:55:46 volumio volumio[1167]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Dec 05 22:55:46 volumio volumio[1167]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Dec 05 22:55:46 volumio volumio[1167]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Dec 05 22:55:46 volumio volumio[1167]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Dec 05 22:55:46 volumio volumio[1167]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Dec 05 22:55:46 volumio volumio[1167]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Dec 05 22:55:46 volumio volumio[1167]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Dec 05 22:55:46 volumio volumio[1167]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Dec 05 22:55:46 volumio volumio[1167]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Dec 05 22:55:46 volumio volumio[1167]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Dec 05 22:55:46 volumio volumio[1167]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Dec 05 22:55:46 volumio volumio[1167]: errno: -20, Dec 05 22:55:46 volumio volumio[1167]: syscall: 'scandir', Dec 05 22:55:46 volumio volumio[1167]: code: 'ENOTDIR', Dec 05 22:55:46 volumio volumio[1167]: path: '/tmp/peppyrunning' Dec 05 22:55:46 volumio volumio[1167]: } Dec 05 22:55:46 volumio volumio[1167]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 22:55:46 volumio sudo[7476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-05 22:54 Dec 05 22:55:46 volumio sudo[7476]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 07:31:13 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="674d725e3f749f2a23785c9f94a28aa3"