-- Logs begin at Sun 2025-12-28 18:41:57 CST, end at Sun 2025-12-28 18:52:37 CST. -- Dec 28 18:51:16 volumio-x86 volumio[1174]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 28 18:51:16 volumio-x86 volumio[1174]: info: Retrying Login Due to Network Error Dec 28 18:51:17 volumio-x86 ntpd[4049]: Soliciting pool server 2606:4700:f1::123 Dec 28 18:51:22 volumio-x86 ntpd[4049]: Soliciting pool server 84.16.73.33 Dec 28 18:51:23 volumio-x86 ntpd[4049]: Soliciting pool server 139.199.214.202 Dec 28 18:51:23 volumio-x86 ntpd[4049]: Soliciting pool server 193.182.111.142 Dec 28 18:51:24 volumio-x86 ntpd[4049]: Soliciting pool server 111.230.189.174 Dec 28 18:51:24 volumio-x86 ntpd[4049]: Soliciting pool server 210.28.130.4 Dec 28 18:51:24 volumio-x86 ntpd[4049]: Soliciting pool server 210.28.130.4 Dec 28 18:51:25 volumio-x86 ntpd[4049]: Soliciting pool server 162.159.200.123 Dec 28 18:51:25 volumio-x86 ntpd[4049]: Soliciting pool server 139.199.215.251 Dec 28 18:51:26 volumio-x86 volumio[1174]: info: MyVolumio login type: Token Dec 28 18:51:26 volumio-x86 ntpd[4049]: Soliciting pool server 106.54.244.49 Dec 28 18:51:26 volumio-x86 ntpd[4049]: Soliciting pool server 193.182.111.14 Dec 28 18:51:44 volumio-x86 sudo[5493]: pam_unix(sudo:session): session closed for user root Dec 28 18:51:55 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioGetState Dec 28 18:51:55 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:51:55 volumio-x86 sudo[6126]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Dec 28 18:51:55 volumio-x86 sudo[6126]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 28 18:51:56 volumio-x86 volumio[1174]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 28 18:51:56 volumio-x86 volumio[1174]: info: Retrying Login Due to Network Error Dec 28 18:51:58 volumio-x86 volumio[1174]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6 Dec 28 18:51:58 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioGetState Dec 28 18:51:58 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:51:59 volumio-x86 volumio[1174]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Dec 28 18:51:59 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioGetState Dec 28 18:51:59 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:52:03 volumio-x86 kernel: usb 1-1: new high-speed USB device number 15 using xhci_hcd Dec 28 18:52:04 volumio-x86 kernel: usb 1-1: New USB device found, idVendor=214b, idProduct=7250, bcdDevice= 1.00 Dec 28 18:52:04 volumio-x86 kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Dec 28 18:52:04 volumio-x86 kernel: usb 1-1: Product: USB2.0 HUB Dec 28 18:52:04 volumio-x86 kernel: hub 1-1:1.0: USB hub found Dec 28 18:52:04 volumio-x86 kernel: hub 1-1:1.0: 4 ports detected Dec 28 18:52:06 volumio-x86 volumio[1174]: info: MyVolumio login type: Token Dec 28 18:52:22 volumio-x86 kernel: usb 1-1: USB disconnect, device number 15 Dec 28 18:52:22 volumio-x86 kernel: usb 1-1: new high-speed USB device number 16 using xhci_hcd Dec 28 18:52:22 volumio-x86 kernel: usb 1-1: New USB device found, idVendor=214b, idProduct=7250, bcdDevice= 1.00 Dec 28 18:52:22 volumio-x86 kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Dec 28 18:52:22 volumio-x86 kernel: usb 1-1: Product: USB2.0 HUB Dec 28 18:52:22 volumio-x86 kernel: hub 1-1:1.0: USB hub found Dec 28 18:52:22 volumio-x86 kernel: hub 1-1:1.0: 4 ports detected Dec 28 18:52:30 volumio-x86 nmbd[943]: [2025/12/28 18:52:30.623662, 0] ../source3/libsmb/nmblib.c:917(send_udp) Dec 28 18:52:30 volumio-x86 nmbd[943]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Dec 28 18:52:36 volumio-x86 volumio[1174]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 28 18:52:36 volumio-x86 volumio[1174]: info: Retrying Login Due to Network Error Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: new high-speed USB device number 17 using xhci_hcd Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: New USB device found, idVendor=2fc6, idProduct=f801, bcdDevice= 2.01 Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: Product: SXW CTUAD384 PRM-A Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: Manufacturer: SXW Tech Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: SerialNumber: SXW CTUAD Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: 1:4 : unsupported format bits 0x100000000 Dec 28 18:52:36 volumio-x86 kernel: usb 1-1.3: 2:4 : unsupported format bits 0x100000000 Dec 28 18:52:36 volumio-x86 kernel: usbcore: registered new interface driver snd-usb-audio Dec 28 18:52:36 volumio-x86 volumio[1174]: info: No valid Plugin REST Endpoint Dec 28 18:52:36 volumio-x86 volumio[1174]: info: Dec 28 18:52:36 volumio-x86 volumio[1174]: ---------------------------- USB Audio Device Attached Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 28 18:52:36 volumio-x86 systemd-udevd[6229]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreCommandRouter::Close All Modals sent Dec 28 18:52:36 volumio-x86 volumio[1174]: info: Preparing to save Alsa Options, stopping services first Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioGetState Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioPause Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreStateMachine::pause Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreStateMachine::stPlaybackTimer Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreStateMachine::servicePause Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreCommandRouter::servicePause Dec 28 18:52:36 volumio-x86 volumio[1174]: info: ControllerMpd::pause Dec 28 18:52:36 volumio-x86 volumio[1174]: verbose: ControllerMpd::sendMpdCommand pause Dec 28 18:52:36 volumio-x86 volumio[1174]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"SXW CTUAD384 PRM-A","alsacard":"PRMA"},"i2s":false} Dec 28 18:52:36 volumio-x86 volumio[1174]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 28 18:52:37 volumio-x86 volumio[1174]: info: Setting default mixerSoftMaster for Softvolume device Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 28 18:52:37 volumio-x86 volumio[1174]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 28 18:52:37 volumio-x86 volumio[1174]: info: Disabling external Volume Control Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 28 18:52:37 volumio-x86 volumio[1174]: info: Enable softmixer device for audio device undefined Dec 28 18:52:37 volumio-x86 volumio[1174]: info: Dec 28 18:52:37 volumio-x86 volumio[1174]: ---------------------------- MPD announces state update: player Dec 28 18:52:37 volumio-x86 volumio[1174]: info: sendMpdCommand pause took 318 milliseconds Dec 28 18:52:37 volumio-x86 volumio[1174]: info: ControllerMpd::getState Dec 28 18:52:37 volumio-x86 volumio[1174]: verbose: ControllerMpd::sendMpdCommand status Dec 28 18:52:37 volumio-x86 volumio[1174]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'SoftMaster',0 Dec 28 18:52:37 volumio-x86 volumio[1174]: info: sendMpdCommand status took 5 milliseconds Dec 28 18:52:37 volumio-x86 volumio[1174]: verbose: ControllerMpd::parseState Dec 28 18:52:37 volumio-x86 volumio[1174]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioGetState Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreStateMachine::pushState Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 28 18:52:37 volumio-x86 volumio[1174]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 28 18:52:37 volumio-x86 volumio[1174]: verbose: ControllerMpd::parseTrackInfo Dec 28 18:52:37 volumio-x86 volumio[1174]: info: ControllerMpd::pushState Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::servicePushState Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:52:37 volumio-x86 volumio[1174]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":229758,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"999 Kbps","isStreaming":false,"title":"那一夜 (红音堂·姚璎格)","artist":"姚璎格","album":"红音堂·玫瑰人生·姚璎格 (发烧女中音)","uri":"INTERNAL/musics/红音堂·玫瑰人生·姚璎格 (发烧女中音)/姚璎格-那一夜 (红音堂·姚璎格).flac","trackType":"flac"} Dec 28 18:52:37 volumio-x86 volumio[1174]: verbose: CURRENT POSITION 2 Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreStateMachine::syncState stateService pause Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreStateMachine::syncState currentStatus pause Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreStateMachine::pushState Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CorePlayQueue::getTrack 2 Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 28 18:52:37 volumio-x86 volumio[1174]: info: CoreStateMachine::stPlaybackTimer Dec 28 18:52:37 volumio-x86 volumio[1174]: info: ------------------------------ 48ms Dec 28 18:52:37 volumio-x86 volumio[1174]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 28 18:52:37 volumio-x86 volumio[1174]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Dec 28 18:52:37 volumio-x86 volumio[1174]: at Object.readdirSync (fs.js:1048:3) Dec 28 18:52:37 volumio-x86 volumio[1174]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Dec 28 18:52:37 volumio-x86 volumio[1174]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Dec 28 18:52:37 volumio-x86 volumio[1174]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Dec 28 18:52:37 volumio-x86 volumio[1174]: errno: -20, Dec 28 18:52:37 volumio-x86 volumio[1174]: syscall: 'scandir', Dec 28 18:52:37 volumio-x86 volumio[1174]: code: 'ENOTDIR', Dec 28 18:52:37 volumio-x86 volumio[1174]: path: '/tmp/peppyrunning' Dec 28 18:52:37 volumio-x86 volumio[1174]: } Dec 28 18:52:37 volumio-x86 volumio[1174]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 28 18:52:37 volumio-x86 sudo[6277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-28 18:51 Dec 28 18:52:37 volumio-x86 sudo[6277]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"