-- Logs begin at Sat 2025-07-05 13:37:51 CST, end at Sat 2025-07-05 13:42:55 CST. --
Jul 05 13:41:17 volumio-x86 kernel: usb 5-3: new full-speed USB device number 2 using ohci-pci
Jul 05 13:41:17 volumio-x86 kernel: usb 5-3: New USB device found, idVendor=367b, idProduct=1919, bcdDevice=29.01
Jul 05 13:41:17 volumio-x86 kernel: usb 5-3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jul 05 13:41:17 volumio-x86 kernel: usb 5-3: Product: USB Receiver
Jul 05 13:41:17 volumio-x86 kernel: usb 5-3: Manufacturer: USB Receiver
Jul 05 13:41:17 volumio-x86 kernel: input: USB Receiver USB Receiver as /devices/pci0000:00/0000:00:13.0/usb5/5-3/5-3:1.0/0003:367B:1919.0002/input/input10
Jul 05 13:41:17 volumio-x86 kernel: hid-generic 0003:367B:1919.0002: input,hidraw1: USB HID v1.11 Mouse [USB Receiver USB Receiver] on usb-0000:00:13.0-3/input0
Jul 05 13:41:17 volumio-x86 kernel: usbcore: registered new interface driver usbmouse
Jul 05 13:41:18 volumio-x86 systemd-udevd[2787]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 05 13:41:18 volumio-x86 systemd-udevd[2788]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jul 05 13:41:24 volumio-x86 volumio[1096]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jul 05 13:41:24 volumio-x86 volumio[1096]: info: Retrying Login Due to Network Error
Jul 05 13:41:27 volumio-x86 sudo[2181]: pam_unix(sudo:session): session closed for user root
Jul 05 13:41:34 volumio-x86 volumio[1096]: info: MyVolumio login type: Token
Jul 05 13:41:43 volumio-x86 kernel: usb 2-2: reset high-speed USB device number 2 using ehci-pci
Jul 05 13:41:43 volumio-x86 kernel: sd 3:0:0:0: [sdb] tag#0 FAILED Result: hostbyte=DID_OK driverbyte=DRIVER_OK cmd_age=0s
Jul 05 13:41:43 volumio-x86 kernel: sd 3:0:0:0: [sdb] tag#0 Sense Key : Not Ready [current]
Jul 05 13:41:43 volumio-x86 kernel: sd 3:0:0:0: [sdb] tag#0 Add. Sense: Medium not present
Jul 05 13:41:43 volumio-x86 kernel: sd 3:0:0:0: [sdb] tag#0 CDB: Read(10) 28 00 06 36 98 40 00 00 f0 00
Jul 05 13:41:43 volumio-x86 kernel: I/O error, dev sdb, sector 104241216 op 0x0:(READ) flags 0x84700 phys_seg 30 prio class 2
Jul 05 13:41:43 volumio-x86 kernel: sd 3:0:0:0: [sdb] 125173760 512-byte logical blocks: (64.1 GB/59.7 GiB)
Jul 05 13:41:48 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioGetState
Jul 05 13:41:48 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 0
Jul 05 13:41:48 volumio-x86 sudo[2909]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Jul 05 13:41:48 volumio-x86 sudo[2909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 05 13:41:52 volumio-x86 volumio[1096]: 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
Jul 05 13:41:52 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioGetState
Jul 05 13:41:52 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 0
Jul 05 13:42:04 volumio-x86 volumio[1096]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jul 05 13:42:04 volumio-x86 volumio[1096]: info: Retrying Login Due to Network Error
Jul 05 13:42:07 volumio-x86 sudo[2909]: pam_unix(sudo:session): session closed for user root
Jul 05 13:42:09 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioGetQueue
Jul 05 13:42:09 volumio-x86 volumio[1096]: info: CoreStateMachine::getQueue
Jul 05 13:42:09 volumio-x86 volumio[1096]: info: CorePlayQueue::getQueue
Jul 05 13:42:10 volumio-x86 volumio[1096]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Charlie%20Puth/How%20Long/af82923e-6ac5-4222-a48c-f55cefb5dfed.png'
Jul 05 13:42:14 volumio-x86 volumio[1096]: info: MyVolumio login type: Token
Jul 05 13:42:17 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioGetState
Jul 05 13:42:17 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 0
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 0
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: Prefetching next song
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: DOING PREFETCH IN MPD
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand add "USB/4F7C-C5CB/音乐排行榜(flac)/刘维、薛之谦 - 婚礼的祝福.flac"
Jul 05 13:42:24 volumio-x86 volumio[1096]: info:
Jul 05 13:42:24 volumio-x86 volumio[1096]: ---------------------------- MPD announces system playlist update
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: Ignoring MPD Status Update
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: sendMpdCommand add "USB/4F7C-C5CB/音乐排行榜(flac)/刘维、薛之谦 - 婚礼的祝福.flac" took 6 milliseconds
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand consume 1
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: ------------------------------ 8ms
Jul 05 13:42:24 volumio-x86 volumio[1096]: info:
Jul 05 13:42:24 volumio-x86 volumio[1096]: ---------------------------- MPD announces state update: options
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: sendMpdCommand consume 1 took 10 milliseconds
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: ControllerMpd::getState
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: sendMpdCommand status took 6 milliseconds
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: ControllerMpd::parseState
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: ControllerMpd::parseTrackInfo
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: ControllerMpd::pushState
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreCommandRouter::servicePushState
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 0
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":205328,"duration":216,"samplerate":"96 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"972 Kbps","isStreaming":false,"title":"G.E.M.邓紫棋 - Victoria.flac","artist":null,"album":null,"uri":"USB/4F7C-C5CB/音乐排行榜(flac)/G.E.M.邓紫棋 - Victoria.flac","trackType":"flac"}
Jul 05 13:42:24 volumio-x86 volumio[1096]: verbose: CURRENT POSITION 0
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreStateMachine::syncState stateService play
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreStateMachine::syncState currentStatus play
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: Received an update from plugin. extracting info from payload
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreStateMachine::pushState
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 0
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioPushState
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreStateMachine::pushState
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 0
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioPushState
Jul 05 13:42:24 volumio-x86 volumio[1096]: info: ------------------------------ 66ms
Jul 05 13:42:28 volumio-x86 volumio[1096]: info: CoreStateMachine::startPlaybackTimer
Jul 05 13:42:28 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:28 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioGetState
Jul 05 13:42:28 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:28 volumio-x86 sudo[3159]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Jul 05 13:42:28 volumio-x86 sudo[3159]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 05 13:42:29 volumio-x86 volumio[1096]: info: CoreStateMachine::pushState
Jul 05 13:42:29 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:29 volumio-x86 volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 13:42:29 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioPushState
Jul 05 13:42:31 volumio-x86 volumio[1096]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 05 13:42:33 volumio-x86 volumio[1096]: 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
Jul 05 13:42:33 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioGetState
Jul 05 13:42:33 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:34 volumio-x86 sudo[3159]: pam_unix(sudo:session): session closed for user root
Jul 05 13:42:34 volumio-x86 volumio[1096]: info:
Jul 05 13:42:34 volumio-x86 volumio[1096]: ---------------------------- MPD announces system playlist update
Jul 05 13:42:34 volumio-x86 volumio[1096]: info: Ignoring MPD Status Update
Jul 05 13:42:34 volumio-x86 volumio[1096]: info:
Jul 05 13:42:34 volumio-x86 volumio[1096]: ---------------------------- MPD announces state update: player
Jul 05 13:42:34 volumio-x86 volumio[1096]: info: ControllerMpd::getState
Jul 05 13:42:34 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 13:42:34 volumio-x86 volumio[1096]: info: ------------------------------ 5ms
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: sendMpdCommand status took 836 milliseconds
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: ControllerMpd::parseState
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 13:42:35 volumio-x86 volumio[1096]: info:
Jul 05 13:42:35 volumio-x86 volumio[1096]: ---------------------------- MPD announces state update: player
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: ControllerMpd::getState
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand status
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: ControllerMpd::parseTrackInfo
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: ControllerMpd::pushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::servicePushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"刘维、薛之谦 - 婚礼的祝福.flac","artist":null,"album":null,"uri":"USB/4F7C-C5CB/音乐排行榜(flac)/刘维、薛之谦 - 婚礼的祝福.flac","trackType":"flac"}
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: CURRENT POSITION 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::syncState stateService play
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::syncState currentStatus play
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: Received an update from plugin. extracting info from payload
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::pushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioPushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::pushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioPushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: ------------------------------ 888ms
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: sendMpdCommand status took 41 milliseconds
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: ControllerMpd::parseState
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: sendMpdCommand playlistinfo took 38 milliseconds
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: ControllerMpd::parseTrackInfo
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: ControllerMpd::pushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::servicePushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: STATE SERVICE {"status":"play","position":0,"seek":83,"duration":276,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"687 Kbps","isStreaming":false,"title":"刘维、薛之谦 - 婚礼的祝福.flac","artist":null,"album":null,"uri":"USB/4F7C-C5CB/音乐排行榜(flac)/刘维、薛之谦 - 婚礼的祝福.flac","trackType":"flac"}
Jul 05 13:42:35 volumio-x86 volumio[1096]: verbose: CURRENT POSITION 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::syncState stateService play
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::syncState currentStatus play
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: Received an update from plugin. extracting info from payload
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::pushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioPushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreStateMachine::pushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CorePlayQueue::getTrack 5
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: CoreCommandRouter::volumioPushState
Jul 05 13:42:35 volumio-x86 volumio[1096]: info: ------------------------------ 136ms
Jul 05 13:42:36 volumio-x86 volumio[1096]: info: CoreCommandRouter::Close All Modals sent
Jul 05 13:42:44 volumio-x86 volumio[1096]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jul 05 13:42:44 volumio-x86 volumio[1096]: info: Retrying Login Due to Network Error
Jul 05 13:42:49 volumio-x86 volumio[1096]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 05 13:42:49 volumio-x86 volumio[1096]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 05 13:42:54 volumio-x86 volumio[1096]: info: MyVolumio login type: Token
Jul 05 13:42:54 volumio-x86 volumio[1096]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 05 13:42:54 volumio-x86 volumio[1096]: Error: connect ETIMEDOUT 104.244.43.231:443
Jul 05 13:42:54 volumio-x86 volumio[1096]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jul 05 13:42:54 volumio-x86 volumio[1096]: errno: -110,
Jul 05 13:42:54 volumio-x86 volumio[1096]: code: 'ETIMEDOUT',
Jul 05 13:42:54 volumio-x86 volumio[1096]: syscall: 'connect',
Jul 05 13:42:54 volumio-x86 volumio[1096]: address: '104.244.43.231',
Jul 05 13:42:54 volumio-x86 volumio[1096]: port: 443
Jul 05 13:42:54 volumio-x86 volumio[1096]: }
Jul 05 13:42:54 volumio-x86 volumio[1096]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 05 13:42:55 volumio-x86 sudo[3307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-05 13:41
Jul 05 13:42:55 volumio-x86 sudo[3307]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"