-- Logs begin at Thu 2019-02-14 19:11:58 KST, end at Sun 2025-09-14 15:48:43 KST. --
Sep 14 15:47:00 volumio2545 kernel: usb usb2-port4: over-current change #457
Sep 14 15:47:00 volumio2545 kernel: usb usb2-port1: over-current change #467
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] 976773168 512-byte logical blocks: (500 GB/466 GiB)
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] Disabling FUA
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Sep 14 15:47:00 volumio2545 kernel: sda: sda1 sda2
Sep 14 15:47:00 volumio2545 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Sep 14 15:47:09 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:09+09:00" level=trace msg="sent dealer ping"
Sep 14 15:47:09 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:09+09:00" level=trace msg="received dealer pong"
Sep 14 15:47:10 volumio2545 kernel: usb usb2-port1: over-current change #468
Sep 14 15:47:10 volumio2545 kernel: usb 1-1-port1: over-current change #465
Sep 14 15:47:10 volumio2545 kernel: usb usb2-port2: over-current change #463
Sep 14 15:47:10 volumio2545 kernel: usb 1-1-port2: over-current change #461
Sep 14 15:47:10 volumio2545 kernel: usb 2-2: USB disconnect, device number 11
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#18 uas_zap_pending 0 uas-tag 3 inflight: CMD
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#18 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#19 uas_zap_pending 0 uas-tag 4 inflight: CMD
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#19 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#20 uas_zap_pending 0 uas-tag 5 inflight: CMD
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#18 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=10s
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#20 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#18 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:47:11 volumio2545 kernel: I/O error, dev sda, sector 976772920 op 0x0:(READ) flags 0x80700 phys_seg 9 prio class 2
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#19 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=10s
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#19 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:47:11 volumio2545 kernel: I/O error, dev sda, sector 976773000 op 0x0:(READ) flags 0x80700 phys_seg 13 prio class 2
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#20 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=10s
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] tag#20 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:47:11 volumio2545 kernel: I/O error, dev sda, sector 976773112 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Sep 14 15:47:11 volumio2545 kernel: device offline error, dev sda, sector 976772920 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Sep 14 15:47:11 volumio2545 kernel: Buffer I/O error on dev sda, logical block 122096615, async page read
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Sep 14 15:47:11 volumio2545 kernel: usb 1-1-port3: over-current change #460
Sep 14 15:47:11 volumio2545 kernel: usb 1-1-port4: over-current change #461
Sep 14 15:47:11 volumio2545 kernel: usb 1-1-port1: over-current change #466
Sep 14 15:47:11 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Sep 14 15:47:11 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:11 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_3.0_0000000000080-0:0-part1 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"35","ID_BUS":"usb","ID_INSTANCE":"0:0","ID_MODEL":"3.0","ID_MODEL_ENC":"3.0\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0578","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"7b0d720c-2710-0000-cd95-ebd92dc45b68","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_2_1_0-scsi-0_0_0_0","ID_REVISION":"0508","ID_SERIAL":"USB_3.0_0000000000080-0:0","ID_SERIAL_SHORT":"0000000000080","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"USB\\x20\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"6382","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"545255972"}
Sep 14 15:47:11 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:11 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0-part2 /dev/disk/by-id/usb-USB_3.0_0000000000080-0:0-part2","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"35","ID_BUS":"usb","ID_INSTANCE":"0:0","ID_MODEL":"3.0","ID_MODEL_ENC":"3.0\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0578","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"7b0d720c-2710-0000-cd95-ebd92dc45b68","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_2_1_0-scsi-0_0_0_0","ID_REVISION":"0508","ID_SERIAL":"USB_3.0_0000000000080-0:0","ID_SERIAL_SHORT":"0000000000080","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"USB\\x20\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"6383","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"545255972"}
Sep 14 15:47:11 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:11 volumio2545 kernel: usb 1-1-port2: over-current change #462
Sep 14 15:47:11 volumio2545 kernel: usb usb2-port3: over-current change #460
Sep 14 15:47:12 volumio2545 kernel: usb 1-1-port3: over-current change #461
Sep 14 15:47:12 volumio2545 kernel: usb usb2-port4: over-current change #458
Sep 14 15:47:12 volumio2545 kernel: usb 1-1-port4: over-current change #462
Sep 14 15:47:12 volumio2545 kernel: usb usb2-port1: over-current change #469
Sep 14 15:47:12 volumio2545 kernel: usb 1-1-port1: over-current change #467
Sep 14 15:47:12 volumio2545 kernel: usb usb2-port2: over-current change #464
Sep 14 15:47:13 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=trace msg="emitting websocket event: not_playing"
Sep 14 15:47:13 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:47:13 volumio2545 volumio[997]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:6SbxJAtpM7bPnVEWOgKFV1","play_origin":"com.spotify.gaia"}}
Sep 14 15:47:13 volumio2545 volumio[997]: error: Failed to decode event: not_playing
Sep 14 15:47:13 volumio2545 kernel: usb 2-2: new SuperSpeed USB device number 12 using xhci_hcd
Sep 14 15:47:13 volumio2545 kernel: usb 2-2: New USB device found, idVendor=152d, idProduct=0578, bcdDevice= 5.08
Sep 14 15:47:13 volumio2545 kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 14 15:47:13 volumio2545 kernel: usb 2-2: Product: USB
Sep 14 15:47:13 volumio2545 kernel: usb 2-2: Manufacturer: jmicron
Sep 14 15:47:13 volumio2545 kernel: usb 2-2: SerialNumber: 0000000000080
Sep 14 15:47:13 volumio2545 kernel: scsi host0: uas
Sep 14 15:47:13 volumio2545 kernel: scsi 0:0:0:0: Direct-Access USB 3.0 0508 PQ: 0 ANSI: 6
Sep 14 15:47:13 volumio2545 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] 976773168 512-byte logical blocks: (500 GB/466 GiB)
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] Disabling FUA
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Sep 14 15:47:14 volumio2545 kernel: sda: sda1 sda2
Sep 14 15:47:14 volumio2545 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Sep 14 15:47:14 volumio2545 volumio[997]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1zNXF2svmdlNxfS5XeNUgr","play_origin":"com.spotify.gaia"}}
Sep 14 15:47:14 volumio2545 volumio[997]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1zNXF2svmdlNxfS5XeNUgr","name":"Don't Know Why","artist_names":["Norah Jones"],"album_name":"Come Away With Me (Super Deluxe Edition)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c648a42b5dad72c8aafceeec","position":0,"duration":186251,"release_date":"year:2002 month:2 day:26","track_number":1,"disc_number":1}}
Sep 14 15:47:14 volumio2545 volumio[997]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:1zNXF2svmdlNxfS5XeNUgr","resume":false,"play_origin":"com.spotify.gaia"}}
Sep 14 15:47:14 volumio2545 volumio[997]: SPOTIFY: PUSH STATE SPOTIFY
Sep 14 15:47:14 volumio2545 volumio[997]: SPOTIFY: {"status":"play","service":"spop","title":"Don't Know Why","artist":"Norah Jones","album":"Come Away With Me (Super Deluxe Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e02c648a42b5dad72c8aafceeec","uri":"spotify:track:1zNXF2svmdlNxfS5XeNUgr","trackType":"spotify","seek":0,"duration":186,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Sep 14 15:47:14 volumio2545 volumio[997]: info: CoreCommandRouter::servicePushState
Sep 14 15:47:14 volumio2545 volumio[997]: info: CoreStateMachine::pushState
Sep 14 15:47:14 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 14 15:47:14 volumio2545 volumio[997]: info: CoreCommandRouter::volumioPushState
Sep 14 15:47:14 volumio2545 volumio[997]: SPOTIFY: PUSH STATE SPOTIFY
Sep 14 15:47:14 volumio2545 volumio[997]: SPOTIFY: {"status":"play","service":"spop","title":"Don't Know Why","artist":"Norah Jones","album":"Come Away With Me (Super Deluxe Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e02c648a42b5dad72c8aafceeec","uri":"spotify:track:1zNXF2svmdlNxfS5XeNUgr","trackType":"spotify","seek":0,"duration":186,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Sep 14 15:47:14 volumio2545 volumio[997]: info: CoreCommandRouter::servicePushState
Sep 14 15:47:14 volumio2545 volumio[997]: info: CoreStateMachine::pushState
Sep 14 15:47:14 volumio2545 volumio[997]: info: CoreCommandRouter::volumioPushState
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=trace msg="emitting websocket event: will_play"
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=info msg="loaded track \"Don't Know Why\" (paused: false, position: 0ms, duration: 186251ms, prefetched: true)" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=trace msg="scheduling prefetch in 156s"
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=trace msg="emitting websocket event: metadata"
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Sep 14 15:47:14 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:13+09:00" level=trace msg="emitting websocket event: playing"
Sep 14 15:47:26 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:26+09:00" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:47:29 volumio2545 kernel: usb usb2-port1: over-current change #470
Sep 14 15:47:29 volumio2545 kernel: usb 1-1-port1: over-current change #468
Sep 14 15:47:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:29 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:29 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:29 volumio2545 volumio[997]: verbose: New Socket.io Connection to 192.168.219.114:3000 from 192.168.219.190 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5
Sep 14 15:47:29 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Sep 14 15:47:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Sep 14 15:47:29 volumio2545 kernel: usb usb2-port2: over-current change #465
Sep 14 15:47:29 volumio2545 kernel: usb 1-1-port2: over-current change #463
Sep 14 15:47:30 volumio2545 kernel: usb 2-2: USB disconnect, device number 12
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#1 uas_zap_pending 0 uas-tag 3 inflight: CMD
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#1 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#2 uas_zap_pending 0 uas-tag 4 inflight: CMD
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#2 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#1 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=15s
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#4 uas_zap_pending 0 uas-tag 5 inflight: CMD
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#1 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:47:30 volumio2545 kernel: I/O error, dev sda, sector 976772920 op 0x0:(READ) flags 0x80700 phys_seg 9 prio class 2
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#2 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=15s
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#2 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:47:30 volumio2545 kernel: I/O error, dev sda, sector 976773000 op 0x0:(READ) flags 0x80700 phys_seg 13 prio class 2
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#4 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=15s
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:47:30 volumio2545 kernel: I/O error, dev sda, sector 976773112 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Sep 14 15:47:30 volumio2545 kernel: device offline error, dev sda, sector 976772920 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Sep 14 15:47:30 volumio2545 kernel: Buffer I/O error on dev sda, logical block 122096615, async page read
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Sep 14 15:47:30 volumio2545 kernel: usb 1-1-port3: over-current change #462
Sep 14 15:47:30 volumio2545 kernel: usb 1-1-port4: over-current change #463
Sep 14 15:47:30 volumio2545 kernel: usb 1-1-port1: over-current change #469
Sep 14 15:47:30 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Sep 14 15:47:30 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:30 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"36","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"6428","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"564446244"}
Sep 14 15:47:30 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:30 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"36","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"6427","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"564448994"}
Sep 14 15:47:30 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:30 volumio2545 kernel: usb 1-1-port2: over-current change #464
Sep 14 15:47:30 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:30 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:30 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:30 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:30 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:31 volumio2545 kernel: usb usb2-port3: over-current change #461
Sep 14 15:47:31 volumio2545 kernel: usb usb2-port4: over-current change #459
Sep 14 15:47:31 volumio2545 kernel: usb 1-1.2: new high-speed USB device number 3 using xhci_hcd
Sep 14 15:47:31 volumio2545 kernel: usb usb2-port1: over-current change #471
Sep 14 15:47:31 volumio2545 kernel: usb usb2-port2: over-current change #466
Sep 14 15:47:31 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:32 volumio2545 kernel: usb 1-1-port3: over-current change #463
Sep 14 15:47:32 volumio2545 volumio[997]: verbose: New Socket.io Connection to 192.168.219.114:3000 from 192.168.219.190 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Sep 14 15:47:32 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:32 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Sep 14 15:47:32 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Sep 14 15:47:32 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:32 volumio2545 kernel: usb 2-2: new SuperSpeed USB device number 13 using xhci_hcd
Sep 14 15:47:32 volumio2545 kernel: usb 2-2: New USB device found, idVendor=152d, idProduct=0578, bcdDevice= 5.08
Sep 14 15:47:32 volumio2545 kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 14 15:47:32 volumio2545 kernel: usb 2-2: Product: USB
Sep 14 15:47:32 volumio2545 kernel: usb 2-2: Manufacturer: jmicron
Sep 14 15:47:32 volumio2545 kernel: usb 2-2: SerialNumber: 0000000000080
Sep 14 15:47:32 volumio2545 kernel: scsi host0: uas
Sep 14 15:47:32 volumio2545 kernel: scsi 0:0:0:0: Direct-Access USB 3.0 0508 PQ: 0 ANSI: 6
Sep 14 15:47:32 volumio2545 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] 976773168 512-byte logical blocks: (500 GB/466 GiB)
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] Disabling FUA
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Sep 14 15:47:33 volumio2545 kernel: sda: sda1 sda2
Sep 14 15:47:33 volumio2545 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Sep 14 15:47:33 volumio2545 volumio[997]: verbose: New Socket.io Connection to 192.168.219.114 from 192.168.219.190 UA: Mozilla/5.0 (Linux; Android 12; SM-N971N Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.160 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Sep 14 15:47:32 volumio2545 sudo[2678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 14 15:47:32 volumio2545 sudo[2678]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:32 volumio2545 sudo[2678]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:32 volumio2545 sudo[2681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 14 15:47:32 volumio2545 sudo[2681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:32 volumio2545 sudo[2681]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:33 volumio2545 sudo[2685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 14 15:47:33 volumio2545 sudo[2685]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:33 volumio2545 sudo[2685]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:33 volumio2545 sudo[2687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 14 15:47:33 volumio2545 sudo[2687]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:33 volumio2545 sudo[2687]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:33 volumio2545 volumio[997]: verbose: New Socket.io Connection to 192.168.219.114 from 192.168.219.190 UA: Mozilla/5.0 (Linux; Android 12; SM-N971N Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.160 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 14 15:47:33 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:33 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:33 volumio2545 volumio[997]: info: Listing playlists
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 14 15:47:33 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Sep 14 15:47:34 volumio2545 kernel: usb usb2-port1: over-current change #472
Sep 14 15:47:34 volumio2545 kernel: usb 1-1-port1: over-current change #470
Sep 14 15:47:34 volumio2545 kernel: usb usb2-port2: over-current change #467
Sep 14 15:47:34 volumio2545 kernel: usb 1-1-port2: over-current change #465
Sep 14 15:47:34 volumio2545 kernel: usb 2-2: USB disconnect, device number 13
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 uas_zap_pending 0 uas-tag 3 inflight: CMD
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 uas_zap_pending 0 uas-tag 4 inflight: CMD
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 uas_zap_pending 0 uas-tag 5 inflight: CMD
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=1s
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:47:35 volumio2545 kernel: I/O error, dev sda, sector 976772920 op 0x0:(READ) flags 0x80700 phys_seg 9 prio class 2
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=1s
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:47:35 volumio2545 kernel: I/O error, dev sda, sector 976773000 op 0x0:(READ) flags 0x80700 phys_seg 13 prio class 2
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=1s
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:47:35 volumio2545 kernel: I/O error, dev sda, sector 976773112 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Sep 14 15:47:35 volumio2545 kernel: device offline error, dev sda, sector 976772920 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Sep 14 15:47:35 volumio2545 kernel: Buffer I/O error on dev sda, logical block 122096615, async page read
Sep 14 15:47:35 volumio2545 kernel: usb 1-1-port3: over-current change #464
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Sep 14 15:47:35 volumio2545 kernel: usb 1-1-port4: over-current change #464
Sep 14 15:47:35 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Sep 14 15:47:35 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:35 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"37","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"6479","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"569105251"}
Sep 14 15:47:35 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:35 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"37","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"6478","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"569105620"}
Sep 14 15:47:35 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 14 15:47:35 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:35 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Sep 14 15:47:35 volumio2545 kernel: usb 2-2: new SuperSpeed USB device number 14 using xhci_hcd
Sep 14 15:47:35 volumio2545 volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 15:47:36 volumio2545 kernel: usb 2-2: New USB device found, idVendor=152d, idProduct=0578, bcdDevice= 5.08
Sep 14 15:47:36 volumio2545 kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 14 15:47:36 volumio2545 kernel: usb 2-2: Product: USB
Sep 14 15:47:36 volumio2545 kernel: usb 2-2: Manufacturer: jmicron
Sep 14 15:47:36 volumio2545 kernel: usb 2-2: SerialNumber: 0000000000080
Sep 14 15:47:36 volumio2545 kernel: scsi host0: uas
Sep 14 15:47:36 volumio2545 kernel: scsi 0:0:0:0: Direct-Access USB 3.0 0508 PQ: 0 ANSI: 6
Sep 14 15:47:36 volumio2545 kernel: usb usb2-port3: over-current change #462
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Sep 14 15:47:36 volumio2545 kernel: usb usb2-port4: over-current change #460
Sep 14 15:47:36 volumio2545 kernel: usb usb2-port1: over-current change #473
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] 976773168 512-byte logical blocks: (500 GB/466 GiB)
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] Disabling FUA
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Sep 14 15:47:36 volumio2545 kernel: sda: sda1 sda2
Sep 14 15:47:36 volumio2545 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Sep 14 15:47:36 volumio2545 sudo[2737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Sep 14 15:47:36 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 14 15:47:36 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Sep 14 15:47:36 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Sep 14 15:47:36 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Sep 14 15:47:36 volumio2545 sudo[2737]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:36 volumio2545 sudo[2743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Sep 14 15:47:36 volumio2545 sudo[2743]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:36 volumio2545 sudo[2737]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:36 volumio2545 sudo[2743]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:36 volumio2545 sudo[2749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Sep 14 15:47:36 volumio2545 sudo[2749]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:36 volumio2545 sudo[2756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Sep 14 15:47:36 volumio2545 sudo[2756]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:36 volumio2545 sudo[2749]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:36 volumio2545 sudo[2756]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:36 volumio2545 sudo[2762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 14 15:47:36 volumio2545 sudo[2762]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:36 volumio2545 sudo[2762]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:36 volumio2545 sudo[2765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 14 15:47:36 volumio2545 sudo[2765]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:36 volumio2545 sudo[2765]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:36 volumio2545 sudo[2769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 14 15:47:36 volumio2545 sudo[2769]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:37 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 14 15:47:37 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:37 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:37 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:37 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:37 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:37 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 14 15:47:39 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:39 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:39+09:00" level=trace msg="received accesspoint ping"
Sep 14 15:47:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:39+09:00" level=error msg="did not receive last pong ack from accesspoint, 120s passed"
Sep 14 15:47:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:39+09:00" level=trace msg="sent dealer ping"
Sep 14 15:47:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:39+09:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.219.114:53966->104.199.241.202:4070: use of closed network connection"
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 14 15:47:39 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:39 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:39+09:00" level=trace msg="received dealer pong"
Sep 14 15:47:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:39+09:00" level=debug msg="connected to ap-gae2.spotify.com:443"
Sep 14 15:47:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:39+09:00" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="completed keyexchange"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="completed challenge"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=info msg="authenticated AP" username="31************************gm"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="re-established accesspoint connection"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=trace msg="received accesspoint ping"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481"
Sep 14 15:47:40 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:40+09:00" level=trace msg="received accesspoint pong ack"
Sep 14 15:47:40 volumio2545 sudo[2769]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:43 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 14 15:47:49 volumio2545 sudo[2791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 14 15:47:49 volumio2545 sudo[2791]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:49 volumio2545 sudo[2791]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:49 volumio2545 sudo[2794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 14 15:47:49 volumio2545 sudo[2794]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:49 volumio2545 sudo[2794]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:49 volumio2545 volumio[997]: verbose: New Socket.io Connection to 192.168.219.114 from 192.168.219.183 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Edg/140.0.0.0 Engine version: 3 Transport: polling Total Clients: 9
Sep 14 15:47:49 volumio2545 sudo[2797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 14 15:47:49 volumio2545 sudo[2797]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:49 volumio2545 sudo[2797]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:49 volumio2545 sudo[2800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 14 15:47:49 volumio2545 sudo[2800]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 15:47:49 volumio2545 sudo[2800]: pam_unix(sudo:session): session closed for user root
Sep 14 15:47:49 volumio2545 volumio[997]: verbose: New Socket.io Connection to 192.168.219.114 from 192.168.219.183 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Edg/140.0.0.0 Engine version: 3 Transport: polling Total Clients: 10
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 14 15:47:49 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:49 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:49 volumio2545 volumio[997]: info: Listing playlists
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 14 15:47:49 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Sep 14 15:47:50 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:51 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Sep 14 15:47:51 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 14 15:47:51 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:51 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:51 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:51 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:51 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:51 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:52 volumio2545 go-librespot[1310]: time="2025-09-14T15:47:52+09:00" level=debug msg="fetched chunk 6/14, size: 524288" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:47:52 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 14 15:47:52 volumio2545 volumio[997]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 14 15:47:52 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 14 15:47:52 volumio2545 volumio[997]: info: Received Get System Version
Sep 14 15:47:52 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 14 15:47:52 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:52 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:52 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:52 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:52 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:52 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:53 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 14 15:47:53 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:47:53 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:53 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:53 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:53 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:53 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:59 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 14 15:47:59 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:47:59 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:47:59 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:47:59 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:47:59 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:47:59 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetQueue
Sep 14 15:47:59 volumio2545 volumio[997]: info: CoreStateMachine::getQueue
Sep 14 15:47:59 volumio2545 volumio[997]: info: CorePlayQueue::getQueue
Sep 14 15:48:04 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Sep 14 15:48:04 volumio2545 volumio[997]: info: CURURI: music-library
Sep 14 15:48:04 volumio2545 volumio[997]: error: Failed LSINFO: null
Sep 14 15:48:04 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:04 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:04+09:00" level=debug msg="fetched chunk 7/14, size: 524288" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 uas_eh_abort_handler 0 uas-tag 5 inflight: CMD IN
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 uas_eh_abort_handler 0 uas-tag 4 inflight: CMD IN
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD IN
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:48:07 volumio2545 kernel: scsi host0: uas_eh_device_reset_handler start
Sep 14 15:48:07 volumio2545 kernel: usb 2-2: reset SuperSpeed USB device number 14 using xhci_hcd
Sep 14 15:48:07 volumio2545 kernel: scsi host0: uas_eh_device_reset_handler success
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=30s
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#11 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:48:07 volumio2545 kernel: I/O error, dev sda, sector 976773000 op 0x0:(READ) flags 0x80700 phys_seg 13 prio class 2
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=30s
Sep 14 15:48:07 volumio2545 kernel: sd 0:0:0:0: [sda] tag#10 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:48:07 volumio2545 kernel: I/O error, dev sda, sector 976772920 op 0x0:(READ) flags 0x80700 phys_seg 9 prio class 2
Sep 14 15:48:08 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 14 15:48:08 volumio2545 volumio[997]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 14 15:48:08 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 14 15:48:08 volumio2545 volumio[997]: info: Received Get System Version
Sep 14 15:48:08 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 14 15:48:08 volumio2545 volumio[997]: info: Received Get System Info
Sep 14 15:48:08 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:48:08 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:48:08 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:48:08 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:48:08 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:48:09 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:09+09:00" level=trace msg="sent dealer ping"
Sep 14 15:48:09 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:09+09:00" level=trace msg="received dealer pong"
Sep 14 15:48:11 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Sep 14 15:48:11 volumio2545 volumio[997]: info: CURURI: playlists
Sep 14 15:48:11 volumio2545 volumio[997]: info: Listing playlists
Sep 14 15:48:11 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:11 volumio2545 kernel: usb usb2-port1: over-current change #474
Sep 14 15:48:12 volumio2545 kernel: usb 1-1-port1: over-current change #471
Sep 14 15:48:12 volumio2545 kernel: usb usb2-port2: over-current change #468
Sep 14 15:48:12 volumio2545 kernel: usb 1-1-port2: over-current change #466
Sep 14 15:48:12 volumio2545 kernel: usb 2-2: USB disconnect, device number 14
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#14 uas_zap_pending 0 uas-tag 1 inflight: CMD
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#14 CDB: opcode=0x28 28 00 1b a9 0e 00 00 00 f8 00
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#26 uas_zap_pending 0 uas-tag 2 inflight: CMD
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#26 CDB: opcode=0x28 28 00 3a 38 54 00 00 02 00 00
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#15 uas_zap_pending 0 uas-tag 3 inflight: CMD
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#14 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=4s
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#15 CDB: opcode=0x28 28 00 1b a9 0f 00 00 00 80 00
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#26 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=4s
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 uas_zap_pending 0 uas-tag 4 inflight: CMD
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#14 CDB: opcode=0x28 28 00 1b a9 0e 00 00 00 f8 00
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x28 28 00 1b a9 0f 88 00 00 68 00
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#26 CDB: opcode=0x28 28 00 3a 38 54 00 00 02 00 00
Sep 14 15:48:13 volumio2545 kernel: I/O error, dev sda, sector 464064000 op 0x0:(READ) flags 0x80700 phys_seg 31 prio class 2
Sep 14 15:48:13 volumio2545 kernel: I/O error, dev sda, sector 976770048 op 0x0:(READ) flags 0x80700 phys_seg 64 prio class 2
Sep 14 15:48:13 volumio2545 kernel: device offline error, dev sda, sector 976770048 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Sep 14 15:48:13 volumio2545 kernel: Buffer I/O error on dev sda2, logical block 64088192, async page read
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#15 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=4s
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#15 CDB: opcode=0x28 28 00 1b a9 0f 00 00 00 80 00
Sep 14 15:48:13 volumio2545 kernel: I/O error, dev sda, sector 464064256 op 0x0:(READ) flags 0x80700 phys_seg 16 prio class 2
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=4s
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x28 28 00 1b a9 0f 88 00 00 68 00
Sep 14 15:48:13 volumio2545 kernel: I/O error, dev sda, sector 464064392 op 0x0:(READ) flags 0x80700 phys_seg 13 prio class 2
Sep 14 15:48:13 volumio2545 kernel: device offline error, dev sda, sector 464064000 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Sep 14 15:48:13 volumio2545 kernel: Buffer I/O error on dev sda1, logical block 58007744, async page read
Sep 14 15:48:13 volumio2545 kernel: usb 1-1-port3: over-current change #465
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Sep 14 15:48:13 volumio2545 kernel: usb 1-1-port4: over-current change #465
Sep 14 15:48:13 volumio2545 kernel: usb 1-1-port1: over-current change #472
Sep 14 15:48:13 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Sep 14 15:48:13 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:48:13 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_3.0_0000000000080-0:0-part1 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"38","ID_BUS":"usb","ID_INSTANCE":"0:0","ID_MODEL":"3.0","ID_MODEL_ENC":"3.0\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0578","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"7b0d720c-2710-0000-cd95-ebd92dc45b68","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_2_1_0-scsi-0_0_0_0","ID_REVISION":"0508","ID_SERIAL":"USB_3.0_0000000000080-0:0","ID_SERIAL_SHORT":"0000000000080","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"USB\\x20\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"6527","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"606743351"}
Sep 14 15:48:13 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:48:13 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0-part2 /dev/disk/by-id/usb-USB_3.0_0000000000080-0:0-part2","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"38","ID_BUS":"usb","ID_INSTANCE":"0:0","ID_MODEL":"3.0","ID_MODEL_ENC":"3.0\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0578","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"7b0d720c-2710-0000-cd95-ebd92dc45b68","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_2_1_0-scsi-0_0_0_0","ID_REVISION":"0508","ID_SERIAL":"USB_3.0_0000000000080-0:0","ID_SERIAL_SHORT":"0000000000080","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"USB\\x20\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"6528","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"606742014"}
Sep 14 15:48:13 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:48:13 volumio2545 kernel: usb 1-1-port2: over-current change #467
Sep 14 15:48:13 volumio2545 kernel: usb usb2-port3: over-current change #463
Sep 14 15:48:13 volumio2545 kernel: usb 1-1-port3: over-current change #466
Sep 14 15:48:13 volumio2545 kernel: usb usb2-port4: over-current change #461
Sep 14 15:48:13 volumio2545 kernel: usb 1-1-port4: over-current change #466
Sep 14 15:48:13 volumio2545 kernel: usb usb2-port1: over-current change #475
Sep 14 15:48:13 volumio2545 kernel: usb 1-1-port1: over-current change #473
Sep 14 15:48:14 volumio2545 kernel: usb usb2-port2: over-current change #469
Sep 14 15:48:14 volumio2545 kernel: usb 2-2: new SuperSpeed USB device number 15 using xhci_hcd
Sep 14 15:48:14 volumio2545 kernel: usb 2-2: New USB device found, idVendor=152d, idProduct=0578, bcdDevice= 5.08
Sep 14 15:48:14 volumio2545 kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 14 15:48:14 volumio2545 kernel: usb 2-2: Product: USB
Sep 14 15:48:14 volumio2545 kernel: usb 2-2: Manufacturer: jmicron
Sep 14 15:48:14 volumio2545 kernel: usb 2-2: SerialNumber: 0000000000080
Sep 14 15:48:14 volumio2545 kernel: scsi host0: uas
Sep 14 15:48:14 volumio2545 kernel: scsi 0:0:0:0: Direct-Access USB 3.0 0508 PQ: 0 ANSI: 6
Sep 14 15:48:14 volumio2545 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] 976773168 512-byte logical blocks: (500 GB/466 GiB)
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] Disabling FUA
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Sep 14 15:48:15 volumio2545 kernel: sda: sda1 sda2
Sep 14 15:48:15 volumio2545 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Sep 14 15:48:16 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Sep 14 15:48:16 volumio2545 volumio[997]: info: CURURI: albums://
Sep 14 15:48:16 volumio2545 volumio[997]: info: listAlbums - loading Albums from cache
Sep 14 15:48:16 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:17 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:17+09:00" level=debug msg="fetched chunk 8/14, size: 524288" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:48:23 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Sep 14 15:48:23 volumio2545 volumio[997]: info: CURURI: genres://
Sep 14 15:48:23 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:25 volumio2545 kernel: usb usb2-port1: over-current change #476
Sep 14 15:48:25 volumio2545 kernel: usb 1-1-port1: over-current change #474
Sep 14 15:48:26 volumio2545 kernel: usb usb2-port2: over-current change #470
Sep 14 15:48:26 volumio2545 kernel: usb 1-1-port2: over-current change #468
Sep 14 15:48:26 volumio2545 kernel: usb 2-2: USB disconnect, device number 15
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#22 uas_zap_pending 0 uas-tag 3 inflight: CMD
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#22 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#23 uas_zap_pending 0 uas-tag 4 inflight: CMD
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#23 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#24 uas_zap_pending 0 uas-tag 5 inflight: CMD
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#24 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#22 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=10s
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#22 CDB: opcode=0x28 28 00 3a 38 5f 38 00 00 48 00
Sep 14 15:48:27 volumio2545 kernel: I/O error, dev sda, sector 976772920 op 0x0:(READ) flags 0x80700 phys_seg 9 prio class 2
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#23 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=10s
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#23 CDB: opcode=0x28 28 00 3a 38 5f 88 00 00 68 00
Sep 14 15:48:27 volumio2545 kernel: I/O error, dev sda, sector 976773000 op 0x0:(READ) flags 0x80700 phys_seg 13 prio class 2
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#24 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=10s
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] tag#24 CDB: opcode=0x28 28 00 3a 38 5f f8 00 00 08 00
Sep 14 15:48:27 volumio2545 kernel: I/O error, dev sda, sector 976773112 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Sep 14 15:48:27 volumio2545 kernel: Buffer I/O error on dev sda, logical block 122096615, async page read
Sep 14 15:48:27 volumio2545 kernel: usb 1-1-port3: over-current change #467
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Sep 14 15:48:27 volumio2545 kernel: usb 1-1-port4: over-current change #467
Sep 14 15:48:27 volumio2545 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Sep 14 15:48:27 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:48:27 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"39","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"6572","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"620665119"}
Sep 14 15:48:27 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:48:27 volumio2545 volumio[997]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2/2-2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"39","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"6573","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"620665125"}
Sep 14 15:48:27 volumio2545 volumio[997]: error: Cannot associate FS Label, not mounting
Sep 14 15:48:27 volumio2545 kernel: usb 2-2: new SuperSpeed USB device number 16 using xhci_hcd
Sep 14 15:48:27 volumio2545 kernel: usb 2-2: New USB device found, idVendor=152d, idProduct=0578, bcdDevice= 5.08
Sep 14 15:48:27 volumio2545 kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 14 15:48:27 volumio2545 kernel: usb 2-2: Product: USB
Sep 14 15:48:27 volumio2545 kernel: usb 2-2: Manufacturer: jmicron
Sep 14 15:48:27 volumio2545 kernel: usb 2-2: SerialNumber: 0000000000080
Sep 14 15:48:27 volumio2545 kernel: scsi host0: uas
Sep 14 15:48:27 volumio2545 kernel: usb usb2-port3: over-current change #464
Sep 14 15:48:27 volumio2545 kernel: scsi 0:0:0:0: Direct-Access USB 3.0 0508 PQ: 0 ANSI: 6
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Sep 14 15:48:28 volumio2545 kernel: usb usb2-port4: over-current change #462
Sep 14 15:48:28 volumio2545 kernel: usb usb2-port1: over-current change #477
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] 976773168 512-byte logical blocks: (500 GB/466 GiB)
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] Disabling FUA
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Sep 14 15:48:28 volumio2545 kernel: sda: sda1 sda2
Sep 14 15:48:28 volumio2545 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Sep 14 15:48:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 15:48:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 15:48:29 volumio2545 volumio[997]: info: Discovery: Getting this device information
Sep 14 15:48:29 volumio2545 volumio[997]: info: CoreCommandRouter::volumioGetState
Sep 14 15:48:29 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 15:48:30 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:30+09:00" level=debug msg="fetched chunk 9/14, size: 524288" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:48:32 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Sep 14 15:48:32 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:34 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Sep 14 15:48:35 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:39 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Sep 14 15:48:39 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:39+09:00" level=trace msg="sent dealer ping"
Sep 14 15:48:39 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:39+09:00" level=trace msg="received dealer pong"
Sep 14 15:48:42 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Sep 14 15:48:42 volumio2545 volumio[997]: info: Preload queue cleared
Sep 14 15:48:43 volumio2545 go-librespot[1310]: time="2025-09-14T15:48:43+09:00" level=debug msg="fetched chunk 10/14, size: 524288" uri="spotify:track:1zNXF2svmdlNxfS5XeNUgr"
Sep 14 15:48:43 volumio2545 volumio[997]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Sep 14 15:48:43 volumio2545 volumio[997]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 14 15:48:43 volumio2545 volumio[997]: TypeError: Cannot read property 'length' of undefined
Sep 14 15:48:43 volumio2545 volumio[997]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Sep 14 15:48:43 volumio2545 volumio[997]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Sep 14 15:48:43 volumio2545 volumio[997]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Sep 14 15:48:43 volumio2545 volumio[997]: at Parser.emit (events.js:315:20)
Sep 14 15:48:43 volumio2545 volumio[997]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Sep 14 15:48:43 volumio2545 volumio[997]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Sep 14 15:48:43 volumio2545 volumio[997]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Sep 14 15:48:43 volumio2545 volumio[997]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Sep 14 15:48:43 volumio2545 volumio[997]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Sep 14 15:48:43 volumio2545 volumio[997]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Sep 14 15:48:43 volumio2545 volumio[997]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Sep 14 15:48:43 volumio2545 volumio[997]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Sep 14 15:48:43 volumio2545 volumio[997]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Sep 14 15:48:43 volumio2545 volumio[997]: at IncomingMessage.emit (events.js:327:22)
Sep 14 15:48:43 volumio2545 volumio[997]: at endReadableNT (internal/streams/readable.js:1327:12)
Sep 14 15:48:43 volumio2545 volumio[997]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 14 15:48:43 volumio2545 volumio[997]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 14 15:48:43 volumio2545 sudo[2956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-14 15:47
Sep 14 15:48:43 volumio2545 sudo[2956]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"