-- Logs begin at Wed 2024-09-04 22:24:26 CST, end at Wed 2024-09-04 22:30:08 CST. -- Sep 04 22:29:08 volumio volumio[839]: info: MyVolumio login type: Token Sep 04 22:29:38 volumio volumio[839]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 04 22:29:38 volumio volumio[839]: info: Retrying Login Due to Network Error Sep 04 22:29:48 volumio volumio[839]: info: MyVolumio login type: Token Sep 04 22:29:55 volumio kernel: r8169 0000:04:00.0 eth0: Link is Down Sep 04 22:29:55 volumio dhcpcd[719]: eth0: carrier lost Sep 04 22:29:55 volumio avahi-daemon[594]: Withdrawing address record for 192.168.31.116 on eth0. Sep 04 22:29:55 volumio avahi-daemon[594]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.31.116. Sep 04 22:29:55 volumio avahi-daemon[594]: Interface eth0.IPv4 no longer relevant for mDNS. Sep 04 22:29:55 volumio volumio[839]: info: Discovery: A device disappeared from network Sep 04 22:29:55 volumio volumio[839]: info: Discovery: Device volumio disappeared from network Sep 04 22:29:55 volumio dhcpcd[719]: eth0: deleting route to 192.168.31.0/24 Sep 04 22:29:55 volumio dhcpcd[719]: eth0: deleting default route via 192.168.31.1 Sep 04 22:29:56 volumio ifplugd(eth0)[812]: Link beat lost. Sep 04 22:29:57 volumio ntpd[1133]: Deleting interface #3 eth0, 192.168.31.116#123, interface stats: received=78, sent=97, dropped=0, active_time=274 secs Sep 04 22:29:57 volumio ntpd[1133]: 78.46.102.180 local addr 192.168.31.116 -> Sep 04 22:29:57 volumio ntpd[1133]: 193.182.111.142 local addr 192.168.31.116 -> Sep 04 22:29:57 volumio ntpd[1133]: 193.182.111.143 local addr 192.168.31.116 -> Sep 04 22:29:57 volumio ntpd[1133]: 185.209.85.222 local addr 192.168.31.116 -> Sep 04 22:29:57 volumio ntpd[1133]: 119.28.183.184 local addr 192.168.31.116 -> Sep 04 22:29:57 volumio ntpd[1133]: 95.111.202.5 local addr 192.168.31.116 -> Sep 04 22:29:57 volumio ntpd[1133]: 84.16.67.12 local addr 192.168.31.116 -> Sep 04 22:29:57 volumio ntpd[1133]: 202.118.1.81 local addr 192.168.31.116 -> Sep 04 22:29:58 volumio kernel: r8169 0000:04:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Sep 04 22:29:58 volumio dhcpcd[719]: eth0: carrier acquired Sep 04 22:29:58 volumio dhcpcd[719]: eth0: IAID 04:db:26:59 Sep 04 22:29:58 volumio ifplugd(eth0)[812]: Link beat detected. Sep 04 22:29:58 volumio dhcpcd[719]: eth0: soliciting an IPv6 router Sep 04 22:29:59 volumio dhcpcd[719]: eth0: rebinding lease of 192.168.31.116 Sep 04 22:29:59 volumio dhcpcd[719]: eth0: probing address 192.168.31.116/24 Sep 04 22:30:04 volumio dhcpcd[719]: eth0: leased 192.168.31.116 for 43200 seconds Sep 04 22:30:04 volumio dhcpcd[719]: eth0: adding route to 192.168.31.0/24 Sep 04 22:30:04 volumio dhcpcd[719]: eth0: adding default route via 192.168.31.1 Sep 04 22:30:04 volumio avahi-daemon[594]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.31.116. Sep 04 22:30:04 volumio avahi-daemon[594]: New relevant interface eth0.IPv4 for mDNS. Sep 04 22:30:04 volumio avahi-daemon[594]: Registering new address record for 192.168.31.116 on eth0.IPv4. Sep 04 22:30:05 volumio ntpd[1133]: ntpd exiting on signal 15 (Terminated) Sep 04 22:30:05 volumio systemd[1]: Stopping Network Time Service... Sep 04 22:30:05 volumio systemd[1]: ntp.service: Succeeded. Sep 04 22:30:05 volumio systemd[1]: Stopped Network Time Service. Sep 04 22:30:05 volumio systemd[1]: Starting Network Time Service... Sep 04 22:30:05 volumio ntpd[2279]: ntpd 4.2.8p12@1.3728-o (1): Starting Sep 04 22:30:05 volumio ntpd[2279]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Sep 04 22:30:05 volumio systemd[1]: Started Network Time Service. Sep 04 22:30:05 volumio ntpd[2285]: proto: precision = 0.255 usec (-22) Sep 04 22:30:05 volumio ntpd[2285]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Sep 04 22:30:05 volumio ntpd[2285]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Sep 04 22:30:05 volumio ntpd[2285]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 617 days ago Sep 04 22:30:05 volumio ntpd[2285]: Listen and drop on 0 v6wildcard [::]:123 Sep 04 22:30:05 volumio ntpd[2285]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 04 22:30:05 volumio ntpd[2285]: Listen normally on 2 lo 127.0.0.1:123 Sep 04 22:30:05 volumio ntpd[2285]: Listen normally on 3 eth0 192.168.31.116:123 Sep 04 22:30:05 volumio ntpd[2285]: Listening on routing socket on fd #20 for interface updates Sep 04 22:30:05 volumio ntpd[2285]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 04 22:30:05 volumio ntpd[2285]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 04 22:30:05 volumio volumio[839]: info: Discovery: adding 492524ff-0d18-4e9b-b0b7-e00a3046faf7 Sep 04 22:30:05 volumio volumio[839]: info: Discovery: Found device Volumio Sep 04 22:30:05 volumio volumio[839]: info: CoreCommandRouter::volumioGetState Sep 04 22:30:05 volumio volumio[839]: info: CorePlayQueue::getTrack 0 Sep 04 22:30:06 volumio ntpd[2285]: Soliciting pool server 185.209.85.222 Sep 04 22:30:08 volumio volumio[839]: info: CoreCommandRouter::volumioPause Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::pause Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::stPlaybackTimer Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::servicePause Sep 04 22:30:08 volumio volumio[839]: info: CorePlayQueue::getTrack 0 Sep 04 22:30:08 volumio volumio[839]: info: CoreCommandRouter::servicePause Sep 04 22:30:08 volumio volumio[839]: info: ControllerMpd::pause Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand pause Sep 04 22:30:08 volumio volumio[839]: info: sendMpdCommand pause took 3 milliseconds Sep 04 22:30:08 volumio volumio[839]: info: Sep 04 22:30:08 volumio volumio[839]: ---------------------------- MPD announces state update: player Sep 04 22:30:08 volumio volumio[839]: info: ControllerMpd::getState Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Sep 04 22:30:08 volumio volumio[839]: info: Sep 04 22:30:08 volumio volumio[839]: ---------------------------- MPD announces state update: player Sep 04 22:30:08 volumio volumio[839]: info: ControllerMpd::getState Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand status Sep 04 22:30:08 volumio volumio[839]: info: sendMpdCommand status took 5 milliseconds Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::parseState Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 22:30:08 volumio volumio[839]: info: sendMpdCommand status took 4 milliseconds Sep 04 22:30:08 volumio volumio[839]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::parseState Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Sep 04 22:30:08 volumio volumio[839]: info: ControllerMpd::pushState Sep 04 22:30:08 volumio volumio[839]: info: CoreCommandRouter::servicePushState Sep 04 22:30:08 volumio volumio[839]: info: CorePlayQueue::getTrack 0 Sep 04 22:30:08 volumio volumio[839]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85928,"duration":281,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5306 Kbps","isStreaming":false,"title":"長い間","artist":"Kiroro","album":"Nagai Aida ～Kiroro no Mori～","uri":"USB/Kiroro - 長い間.flac","trackType":"flac"} Sep 04 22:30:08 volumio volumio[839]: verbose: CURRENT POSITION 0 Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::syncState stateService pause Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus pause Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::pushState Sep 04 22:30:08 volumio volumio[839]: info: CorePlayQueue::getTrack 0 Sep 04 22:30:08 volumio volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 22:30:08 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::stPlaybackTimer Sep 04 22:30:08 volumio volumio[839]: info: ------------------------------ 45ms Sep 04 22:30:08 volumio volumio[839]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 04 22:30:08 volumio volumio[839]: verbose: ControllerMpd::parseTrackInfo Sep 04 22:30:08 volumio volumio[839]: info: ControllerMpd::pushState Sep 04 22:30:08 volumio volumio[839]: info: CoreCommandRouter::servicePushState Sep 04 22:30:08 volumio volumio[839]: info: CorePlayQueue::getTrack 0 Sep 04 22:30:08 volumio volumio[839]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85928,"duration":281,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5306 Kbps","isStreaming":false,"title":"長い間","artist":"Kiroro","album":"Nagai Aida ～Kiroro no Mori～","uri":"USB/Kiroro - 長い間.flac","trackType":"flac"} Sep 04 22:30:08 volumio volumio[839]: verbose: CURRENT POSITION 0 Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::syncState stateService pause Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::syncState currentStatus pause Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::pushState Sep 04 22:30:08 volumio volumio[839]: info: CorePlayQueue::getTrack 0 Sep 04 22:30:08 volumio volumio[839]: info: CoreCommandRouter::volumioPushState Sep 04 22:30:08 volumio volumio[839]: info: CoreStateMachine::stPlaybackTimer Sep 04 22:30:08 volumio volumio[839]: info: ------------------------------ 103ms Sep 04 22:30:08 volumio volumio[839]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 22:30:08 volumio volumio[839]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Sep 04 22:30:08 volumio volumio[839]: at Object.readdirSync (fs.js:1048:3) Sep 04 22:30:08 volumio volumio[839]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Sep 04 22:30:08 volumio volumio[839]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Sep 04 22:30:08 volumio volumio[839]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Sep 04 22:30:08 volumio volumio[839]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Sep 04 22:30:08 volumio volumio[839]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Sep 04 22:30:08 volumio volumio[839]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Sep 04 22:30:08 volumio volumio[839]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Sep 04 22:30:08 volumio volumio[839]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Sep 04 22:30:08 volumio volumio[839]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Sep 04 22:30:08 volumio volumio[839]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Sep 04 22:30:08 volumio volumio[839]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Sep 04 22:30:08 volumio volumio[839]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Sep 04 22:30:08 volumio volumio[839]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Sep 04 22:30:08 volumio volumio[839]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Sep 04 22:30:08 volumio volumio[839]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Sep 04 22:30:08 volumio volumio[839]: errno: -20, Sep 04 22:30:08 volumio volumio[839]: syscall: 'scandir', Sep 04 22:30:08 volumio volumio[839]: code: 'ENOTDIR', Sep 04 22:30:08 volumio volumio[839]: path: '/tmp/peppyrunning' Sep 04 22:30:08 volumio volumio[839]: } Sep 04 22:30:08 volumio volumio[839]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 22:30:08 volumio sudo[2314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 22:29 Sep 04 22:30:08 volumio sudo[2314]: 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"