-- Logs begin at Thu 2025-05-29 15:41:58 UTC, end at Thu 2025-05-29 16:43:22 UTC. -- May 29 16:42:08 volumio volumio[703]: info: Preload queue cleared May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::volumioReplaceandPlayItems May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::ClearQueue May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::stop May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::stPlaybackTimer May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::updateTrackBlock May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrackBlock May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::pushState May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 0 May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::volumioPushState May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::serviceStop May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 0 May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::serviceStop May 29 16:42:08 volumio volumio[703]: info: ControllerMpd::stop May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand stop May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::clearPlayQueue May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::saveQueue May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::volumioPushQueue May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::addQueueItems May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::addQueueItems May 29 16:42:08 volumio volumio[703]: info: Preload queue cleared May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 滚滚红尘.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 滚滚红尘.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 胭脂扣.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 胭脂扣.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 叛逆.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 叛逆.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 笑看風雲.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 笑看風雲.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 情字.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 情字.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 失戀.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 失戀.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 娘心.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 娘心.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 焚情.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 焚情.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 一對舊皮鞋.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 一對舊皮鞋.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 梅花三弄.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 梅花三弄.wav May 29 16:42:08 volumio volumio[703]: info: Adding Item to queue: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 幾分傷心幾分痴.wav May 29 16:42:08 volumio volumio[703]: info: Using cached record of: music-library/USB/KINGSTON/刘亮鹭/刘亮鹭 幾分傷心幾分痴.wav May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::volumioPushQueue May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::saveQueue May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::updateTrackBlock May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrackBlock May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::volumioPlay May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::play index 1 May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::stop May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::play index undefined May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::setConsumeUpdateService undefined May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 1 May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::startPlaybackTimer May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 1 May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/刘亮鹭/刘亮鹭 胭脂扣.wav May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand stop May 29 16:42:08 volumio volumio[703]: info: May 29 16:42:08 volumio volumio[703]: ---------------------------- MPD announces state update: player May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand stop took 152 milliseconds May 29 16:42:08 volumio volumio[703]: info: ControllerMpd::getState May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand status May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand stop took 145 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand clear May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand status took 1 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::parseState May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 16:42:08 volumio volumio[703]: info: May 29 16:42:08 volumio volumio[703]: ---------------------------- MPD announces system playlist update May 29 16:42:08 volumio volumio[703]: info: Ignoring MPD Status Update May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand clear took 2 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/刘亮鹭/刘亮鹭 胭脂扣.wav" May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand playlistinfo took 1 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::parseTrackInfo May 29 16:42:08 volumio volumio[703]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 29 16:42:08 volumio volumio[703]: info: ------------------------------ 4ms May 29 16:42:08 volumio volumio[703]: error: updateQueue error: null May 29 16:42:08 volumio volumio[703]: info: May 29 16:42:08 volumio volumio[703]: ---------------------------- MPD announces system playlist update May 29 16:42:08 volumio volumio[703]: info: Ignoring MPD Status Update May 29 16:42:08 volumio volumio[703]: info: ------------------------------ 4ms May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand add "USB/KINGSTON/刘亮鹭/刘亮鹭 胭脂扣.wav" took 3 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand play May 29 16:42:08 volumio volumio[703]: info: ------------------------------ 2ms May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand play took 1 milliseconds May 29 16:42:08 volumio volumio[703]: info: May 29 16:42:08 volumio volumio[703]: ---------------------------- MPD announces state update: player May 29 16:42:08 volumio volumio[703]: info: ControllerMpd::getState May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand status May 29 16:42:08 volumio volumio[703]: info: May 29 16:42:08 volumio volumio[703]: ---------------------------- MPD announces state update: player May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand status took 3 milliseconds May 29 16:42:08 volumio volumio[703]: info: ControllerMpd::getState May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand status May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::parseState May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand status took 0 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::parseState May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand playlistinfo took 1 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::parseTrackInfo May 29 16:42:08 volumio volumio[703]: info: ControllerMpd::pushState May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::servicePushState May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 1 May 29 16:42:08 volumio volumio[703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??֬??","artist":"??????","album":"????","uri":"USB/KINGSTON/刘亮鹭/刘亮鹭 胭脂扣.wav","trackType":"wav"} May 29 16:42:08 volumio volumio[703]: verbose: CURRENT POSITION 1 May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::syncState stateService play May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::syncState currentStatus stop May 29 16:42:08 volumio volumio[703]: info: ------------------------------ 7ms May 29 16:42:08 volumio volumio[703]: info: sendMpdCommand playlistinfo took 1 milliseconds May 29 16:42:08 volumio volumio[703]: verbose: ControllerMpd::parseTrackInfo May 29 16:42:08 volumio volumio[703]: info: ControllerMpd::pushState May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::servicePushState May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 1 May 29 16:42:08 volumio volumio[703]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??֬??","artist":"??????","album":"????","uri":"USB/KINGSTON/刘亮鹭/刘亮鹭 胭脂扣.wav","trackType":"wav"} May 29 16:42:08 volumio volumio[703]: verbose: CURRENT POSITION 1 May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::syncState stateService play May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::syncState currentStatus play May 29 16:42:08 volumio volumio[703]: info: Received an update from plugin. extracting info from payload May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::pushState May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 1 May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::volumioPushState May 29 16:42:08 volumio volumio[703]: info: CoreStateMachine::pushState May 29 16:42:08 volumio volumio[703]: info: CorePlayQueue::getTrack 1 May 29 16:42:08 volumio volumio[703]: info: CoreCommandRouter::volumioPushState May 29 16:42:08 volumio volumio[703]: info: ------------------------------ 13ms May 29 16:42:13 volumio ntpd[966]: ntpd exiting on signal 15 (Terminated) May 29 16:42:13 volumio ntpd[966]: 202.118.1.81 local addr 192.168.0.112 -> May 29 16:42:13 volumio systemd[1]: Stopping Network Time Service... May 29 16:42:13 volumio ntpd[966]: 162.159.200.1 local addr 192.168.0.112 -> May 29 16:42:13 volumio ntpd[966]: 108.59.2.24 local addr 192.168.0.112 -> May 29 16:42:13 volumio ntpd[966]: 162.159.200.123 local addr 192.168.0.112 -> May 29 16:42:13 volumio ntpd[966]: 185.209.85.222 local addr 192.168.0.112 -> May 29 16:42:13 volumio ntpd[966]: 193.182.111.142 local addr 192.168.0.112 -> May 29 16:42:13 volumio systemd[1]: ntp.service: Succeeded. May 29 16:42:13 volumio systemd[1]: Stopped Network Time Service. May 29 16:42:13 volumio systemd[1]: Starting Network Time Service... May 29 16:42:13 volumio ntpd[1934]: ntpd 4.2.8p12@1.3728-o (1): Starting May 29 16:42:13 volumio ntpd[1934]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 29 16:42:13 volumio systemd[1]: Started Network Time Service. May 29 16:42:13 volumio ntpd[1940]: proto: precision = 0.169 usec (-22) May 29 16:42:13 volumio ntpd[1940]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 29 16:42:13 volumio ntpd[1940]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 29 16:42:13 volumio ntpd[1940]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 884 days ago May 29 16:42:13 volumio ntpd[1940]: Listen and drop on 0 v6wildcard [::]:123 May 29 16:42:13 volumio ntpd[1940]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 29 16:42:13 volumio ntpd[1940]: Listen normally on 2 lo 127.0.0.1:123 May 29 16:42:13 volumio ntpd[1940]: Listen normally on 3 eth0 192.168.0.112:123 May 29 16:42:13 volumio ntpd[1940]: Listening on routing socket on fd #20 for interface updates May 29 16:42:13 volumio ntpd[1940]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 29 16:42:13 volumio ntpd[1940]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 29 16:42:19 volumio ntpd[1940]: Soliciting pool server 193.182.111.143 May 29 16:42:19 volumio ntpd[1940]: Soliciting pool server 119.28.183.184 May 29 16:42:19 volumio ntpd[1940]: Soliciting pool server 84.16.67.12 May 29 16:42:19 volumio ntpd[1940]: Soliciting pool server 193.182.111.14 May 29 16:42:20 volumio ntpd[1940]: Soliciting pool server 84.16.73.33 May 29 16:42:20 volumio ntpd[1940]: Soliciting pool server 202.118.1.81 May 29 16:42:20 volumio ntpd[1940]: Soliciting pool server 202.118.1.81 May 29 16:42:20 volumio ntpd[1940]: Soliciting pool server 119.28.206.193 May 29 16:42:21 volumio ntpd[1940]: Soliciting pool server 116.203.151.74 May 29 16:42:21 volumio ntpd[1940]: Soliciting pool server 202.118.1.130 May 29 16:42:21 volumio ntpd[1940]: Soliciting pool server 211.68.71.26 May 29 16:42:22 volumio ntpd[1940]: Soliciting pool server 193.182.111.141 May 29 16:42:22 volumio ntpd[1940]: Soliciting pool server 240e:92c:0:8000::72:a7 May 29 16:43:22 volumio volumio[703]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 16:43:22 volumio volumio[703]: Error: connect ETIMEDOUT 156.233.67.243:443 May 29 16:43:22 volumio volumio[703]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 29 16:43:22 volumio volumio[703]: errno: -110, May 29 16:43:22 volumio volumio[703]: code: 'ETIMEDOUT', May 29 16:43:22 volumio volumio[703]: syscall: 'connect', May 29 16:43:22 volumio volumio[703]: address: '156.233.67.243', May 29 16:43:22 volumio volumio[703]: port: 443 May 29 16:43:22 volumio volumio[703]: } May 29 16:43:22 volumio volumio[703]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 29 16:43:22 volumio sudo[1958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-29 16:42 May 29 16:43:22 volumio sudo[1958]: 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="1d63a568b7d5e4a317f16be7d0961cbb2d82e282" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="4f8978e0148ab5e1610548b80abf1b4b5e03ea0a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 07 Feb 2023 05:04:19 PM CET" VOLUMIO_VERSION="3.429" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4c8dcdad83349056095d42fbad08221f"