-- Logs begin at Sun 2025-05-11 14:49:15 CST, end at Sun 2025-05-11 15:50:12 CST. -- May 11 15:49:05 volumio volumio[1214]: info: MyVolumio login type: Token May 11 15:49:35 volumio volumio[1214]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 11 15:49:35 volumio volumio[1214]: info: Retrying Login Due to Network Error May 11 15:49:36 volumio systemd[1]: Stopping Network Time Service... May 11 15:49:36 volumio ntpd[1203]: ntpd exiting on signal 15 (Terminated) May 11 15:49:36 volumio ntpd[1203]: 162.159.200.123 local addr 192.168.0.103 -> May 11 15:49:36 volumio systemd[1]: ntp.service: Succeeded. May 11 15:49:36 volumio ntpd[1203]: 193.182.111.141 local addr 192.168.0.103 -> May 11 15:49:36 volumio systemd[1]: Stopped Network Time Service. May 11 15:49:36 volumio ntpd[1203]: 202.118.1.81 local addr 192.168.0.103 -> May 11 15:49:36 volumio ntpd[1203]: 95.111.202.5 local addr 192.168.0.103 -> May 11 15:49:36 volumio ntpd[1203]: 211.68.71.26 local addr 192.168.0.103 -> May 11 15:49:36 volumio ntpd[1203]: 193.182.111.14 local addr 192.168.0.103 -> May 11 15:49:36 volumio systemd[1]: Starting Network Time Service... May 11 15:49:36 volumio ntpd[12358]: ntpd 4.2.8p12@1.3728-o (1): Starting May 11 15:49:36 volumio ntpd[12358]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 11 15:49:36 volumio systemd[1]: Started Network Time Service. May 11 15:49:36 volumio ntpd[12365]: proto: precision = 0.315 usec (-22) May 11 15:49:36 volumio ntpd[12365]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 11 15:49:36 volumio ntpd[12365]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 11 15:49:36 volumio ntpd[12365]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 866 days ago May 11 15:49:36 volumio ntpd[12365]: Listen and drop on 0 v6wildcard [::]:123 May 11 15:49:36 volumio ntpd[12365]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 11 15:49:36 volumio ntpd[12365]: Listen normally on 2 lo 127.0.0.1:123 May 11 15:49:36 volumio ntpd[12365]: Listen normally on 3 wlan0 192.168.0.103:123 May 11 15:49:36 volumio ntpd[12365]: Listening on routing socket on fd #20 for interface updates May 11 15:49:36 volumio ntpd[12365]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 11 15:49:36 volumio ntpd[12365]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 11 15:49:37 volumio ntpd[12365]: Soliciting pool server 162.159.200.1 May 11 15:49:38 volumio ntpd[12365]: Soliciting pool server 116.203.151.74 May 11 15:49:38 volumio ntpd[12365]: Soliciting pool server 162.159.200.123 May 11 15:49:39 volumio ntpd[12365]: Soliciting pool server 193.182.111.142 May 11 15:49:39 volumio ntpd[12365]: Soliciting pool server 45.76.221.157 May 11 15:49:40 volumio ntpd[12365]: Soliciting pool server 116.203.151.74 May 11 15:49:40 volumio ntpd[12365]: Soliciting pool server 211.68.71.26 May 11 15:49:41 volumio ntpd[12365]: Soliciting pool server 193.182.111.14 May 11 15:49:45 volumio volumio[1214]: info: MyVolumio login type: Token May 11 15:50:06 volumio volumio[1214]: info: CorePlayQueue::getTrack 14 May 11 15:50:06 volumio volumio[1214]: info: CorePlayQueue::getTrack 15 May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces system playlist update May 11 15:50:11 volumio volumio[1214]: info: Ignoring MPD Status Update May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces state update: player May 11 15:50:11 volumio volumio[1214]: info: ControllerMpd::getState May 11 15:50:11 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces system playlist update May 11 15:50:11 volumio volumio[1214]: info: Ignoring MPD Status Update May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces state update: player May 11 15:50:11 volumio volumio[1214]: info: ControllerMpd::getState May 11 15:50:11 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces system playlist update May 11 15:50:11 volumio volumio[1214]: info: Ignoring MPD Status Update May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces state update: player May 11 15:50:11 volumio volumio[1214]: info: ControllerMpd::getState May 11 15:50:11 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces system playlist update May 11 15:50:11 volumio volumio[1214]: info: Ignoring MPD Status Update May 11 15:50:11 volumio volumio[1214]: info: May 11 15:50:11 volumio volumio[1214]: ---------------------------- MPD announces state update: player May 11 15:50:11 volumio volumio[1214]: info: ControllerMpd::getState May 11 15:50:11 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 11 15:50:11 volumio volumio[1214]: error: updateQueue error: null May 11 15:50:11 volumio volumio[1214]: info: ------------------------------ 12ms May 11 15:50:11 volumio volumio[1214]: info: sendMpdCommand status took 9 milliseconds May 11 15:50:11 volumio volumio[1214]: info: ------------------------------ 9ms May 11 15:50:11 volumio volumio[1214]: info: sendMpdCommand status took 8 milliseconds May 11 15:50:11 volumio volumio[1214]: info: ------------------------------ 7ms May 11 15:50:11 volumio volumio[1214]: info: sendMpdCommand status took 7 milliseconds May 11 15:50:11 volumio volumio[1214]: verbose: ControllerMpd::parseState May 11 15:50:11 volumio volumio[1214]: verbose: ControllerMpd::parseState May 11 15:50:11 volumio volumio[1214]: verbose: ControllerMpd::parseState May 11 15:50:11 volumio volumio[1214]: info: ControllerMpd::pushState May 11 15:50:11 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 11 15:50:11 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:11 volumio volumio[1214]: info: CorePlayQueue::getTrack 14 May 11 15:50:11 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 15:50:11 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 14 May 11 15:50:12 volumio volumio[1214]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 11 15:50:12 volumio volumio[1214]: verbose: CURRENT POSITION 14 May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState stateService stop May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::stPlaybackTimer May 11 15:50:12 volumio volumio[1214]: info: ControllerMpd::pushState May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 11 15:50:12 volumio volumio[1214]: verbose: CURRENT POSITION 0 May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState stateService stop May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus stop May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: No code May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: ControllerMpd::pushState May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 11 15:50:12 volumio volumio[1214]: verbose: CURRENT POSITION 0 May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState stateService stop May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus stop May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: No code May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: ------------------------------ 92ms May 11 15:50:12 volumio volumio[1214]: info: ------------------------------ 91ms May 11 15:50:12 volumio volumio[1214]: info: ------------------------------ 91ms May 11 15:50:12 volumio volumio[1214]: error: updateQueue error: null May 11 15:50:12 volumio volumio[1214]: info: ------------------------------ 92ms May 11 15:50:12 volumio volumio[1214]: info: sendMpdCommand status took 90 milliseconds May 11 15:50:12 volumio volumio[1214]: verbose: ControllerMpd::parseState May 11 15:50:12 volumio volumio[1214]: info: ControllerMpd::pushState May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 11 15:50:12 volumio volumio[1214]: verbose: CURRENT POSITION 0 May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState stateService stop May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus stop May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: No code May 11 15:50:12 volumio volumio[1214]: info: CoreStateMachine::pushState May 11 15:50:12 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 May 11 15:50:12 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 11 15:50:12 volumio volumio[1214]: info: ------------------------------ 120ms May 11 15:50:12 volumio volumio[1214]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 15:50:12 volumio volumio[1214]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' May 11 15:50:12 volumio volumio[1214]: at Object.readdirSync (fs.js:1048:3) May 11 15:50:12 volumio volumio[1214]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) May 11 15:50:12 volumio volumio[1214]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) May 11 15:50:12 volumio volumio[1214]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) May 11 15:50:12 volumio volumio[1214]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) May 11 15:50:12 volumio volumio[1214]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) May 11 15:50:12 volumio volumio[1214]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) May 11 15:50:12 volumio volumio[1214]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) May 11 15:50:12 volumio volumio[1214]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) May 11 15:50:12 volumio volumio[1214]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) May 11 15:50:12 volumio volumio[1214]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) May 11 15:50:12 volumio volumio[1214]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) May 11 15:50:12 volumio volumio[1214]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) May 11 15:50:12 volumio volumio[1214]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) May 11 15:50:12 volumio volumio[1214]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) May 11 15:50:12 volumio volumio[1214]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { May 11 15:50:12 volumio volumio[1214]: errno: -20, May 11 15:50:12 volumio volumio[1214]: syscall: 'scandir', May 11 15:50:12 volumio volumio[1214]: code: 'ENOTDIR', May 11 15:50:12 volumio volumio[1214]: path: '/tmp/peppyrunning' May 11 15:50:12 volumio volumio[1214]: } May 11 15:50:12 volumio volumio[1214]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 15:50:12 volumio sudo[12517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-11 15:49 May 11 15:50:12 volumio sudo[12517]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"