-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Sun 2023-06-25 16:04:52 UTC. --
Jun 25 16:03:47 volumio kernel: pci 0000:00:1c.4:   bridge window [io  0xd000-0xdfff]
Jun 25 16:03:47 volumio kernel: pci 0000:00:1c.4:   bridge window [mem 0xf7000000-0xf70fffff]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:00: resource 7 [mem 0x7e800000-0xfeafffff window]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:01: resource 0 [io  0xe000-0xefff]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:01: resource 1 [mem 0xf7200000-0xf72fffff]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:02: resource 1 [mem 0xf7100000-0xf71fffff]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:03: resource 0 [io  0xd000-0xdfff]
Jun 25 16:03:47 volumio kernel: pci_bus 0000:03: resource 1 [mem 0xf7000000-0xf70fffff]
Jun 25 16:03:47 volumio kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
Jun 25 16:03:47 volumio kernel: pci 0000:00:1d.0: quirk_usb_early_handoff+0x0/0x630 took 26550 usecs
Jun 25 16:03:47 volumio kernel: PCI: CLS 64 bytes, default 64
Jun 25 16:03:47 volumio kernel: Trying to unpack rootfs image as initramfs...
Jun 25 16:03:47 volumio kernel: Freeing initrd memory: 52368K
Jun 25 16:03:47 volumio kernel: DMAR: Host address width 39
Jun 25 16:03:47 volumio kernel: DMAR: DRHD base: 0x000000fed90000 flags: 0x0
Jun 25 16:03:47 volumio kernel: DMAR: dmar0: reg_base_addr fed90000 ver 1:0 cap 1c0000c40660462 ecap 7e1ff0505e
Jun 25 16:03:47 volumio kernel: DMAR: DRHD base: 0x000000fed91000 flags: 0x1
Jun 25 16:03:47 volumio kernel: DMAR: dmar1: reg_base_addr fed91000 ver 1:0 cap d2008c20660462 ecap f010da
Jun 25 16:03:47 volumio kernel: DMAR: RMRR base: 0x0000007af04000 end: 0x0000007af12fff
Jun 25 16:03:47 volumio kernel: DMAR: RMRR base: 0x0000007c000000 end: 0x0000007e7fffff
Jun 25 16:03:47 volumio kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
Jun 25 16:03:47 volumio kernel: software IO TLB: mapped [mem 0x000000006e693000-0x0000000072693000] (64MB)
Jun 25 16:03:47 volumio kernel: RAPL PMU: API unit is 2^-32 Joules, 4 fixed counters, 655360 ms ovfl timer
Jun 25 16:03:47 volumio kernel: RAPL PMU: hw unit of domain pp0-core 2^-14 Joules
Jun 25 16:03:47 volumio kernel: RAPL PMU: hw unit of domain package 2^-14 Joules
Jun 25 16:03:47 volumio kernel: RAPL PMU: hw unit of domain dram 2^-14 Joules
Jun 25 16:03:47 volumio kernel: RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules
Jun 25 16:03:47 volumio kernel: simple-framebuffer simple-framebuffer.0: framebuffer at 0xe0000000, 0x1d5000 bytes, mapped to 0x00000000cae17e48
Jun 25 16:03:47 volumio kernel: simple-framebuffer simple-framebuffer.0: format=a8r8g8b8, mode=800x600x32, linelength=3200
Jun 25 16:03:47 volumio kernel: Console: switching to colour frame buffer device 100x37
Jun 25 16:03:47 volumio kernel: simple-framebuffer simple-framebuffer.0: fb0: simplefb registered!
Jun 25 16:03:47 volumio kernel: Initialise system trusted keyrings
Jun 25 16:03:47 volumio kernel: workingset: timestamp_bits=46 max_order=19 bucket_order=0
Jun 25 16:03:47 volumio kernel: zbud: loaded
Jun 25 16:03:47 volumio kernel: Key type asymmetric registered
Jun 25 16:03:47 volumio kernel: Asymmetric key parser 'x509' registered
Jun 25 16:03:47 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Jun 25 16:03:47 volumio kernel: io scheduler mq-deadline registered
Jun 25 16:03:47 volumio kernel: io scheduler kyber registered
Jun 25 16:03:47 volumio kernel: pcieport 0000:00:1c.0: PME: Signaling with IRQ 40
Jun 25 16:03:47 volumio kernel: pcieport 0000:00:1c.3: PME: Signaling with IRQ 41
Jun 25 16:03:47 volumio kernel: pcieport 0000:00:1c.4: PME: Signaling with IRQ 42
Jun 25 16:03:47 volumio kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
Jun 25 16:03:47 volumio kernel: intel_idle: MWAIT substates: 0x11142120
Jun 25 16:03:47 volumio kernel: intel_idle: v0.5.1 model 0x3D
Jun 25 16:03:47 volumio kernel: intel_idle: Local APIC timer is reliable in all C-states
Jun 25 16:03:47 volumio kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input0
Jun 25 16:03:47 volumio kernel: ACPI: Sleep Button [SLPB]
Jun 25 16:03:47 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1
Jun 25 16:03:47 volumio kernel: ACPI: Power Button [PWRB]
Jun 25 16:03:47 volumio kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
Jun 25 16:03:47 volumio kernel: ACPI: Power Button [PWRF]
Jun 25 16:03:47 volumio kernel: thermal LNXTHERM:00: registered as thermal_zone0
Jun 25 16:03:47 volumio kernel: ACPI: Thermal Zone [TZ00] (28 C)
Jun 25 16:03:47 volumio kernel: thermal LNXTHERM:01: registered as thermal_zone1
Jun 25 16:03:47 volumio kernel: ACPI: Thermal Zone [TZ01] (30 C)
Jun 25 16:03:47 volumio kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
Jun 25 16:03:47 volumio kernel: 00:01: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
Jun 25 16:03:47 volumio kernel: 00:02: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
Jun 25 16:03:47 volumio kernel: 00:03: ttyS2 at I/O 0x3e8 (irq = 7, base_baud = 115200) is a 16550A
Jun 25 16:03:47 volumio kernel: 00:04: ttyS3 at I/O 0x2e8 (irq = 5, base_baud = 115200) is a 16550A
Jun 25 16:03:47 volumio kernel: 00:05: ttyS4 at I/O 0x2f0 (irq = 6, base_baud = 115200) is a 16550A
Jun 25 16:03:47 volumio kernel: 00:06: ttyS5 at I/O 0x2e0 (irq = 10, base_baud = 115200) is a 16550A
Jun 25 16:03:47 volumio kernel: hpet_acpi_add: no address or irqs in _CRS
Jun 25 16:03:47 volumio kernel: Linux agpgart interface v0.103
Jun 25 16:03:47 volumio kernel: Uniform Multi-Platform E-IDE driver
Jun 25 16:03:47 volumio kernel: ide-gd driver 1.18
Jun 25 16:03:47 volumio kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Jun 25 16:03:47 volumio kernel: ehci-pci: EHCI PCI platform driver
Jun 25 16:03:47 volumio kernel: ehci-pci 0000:00:1d.0: EHCI Host Controller
Jun 25 16:03:47 volumio kernel: ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 1
Jun 25 16:03:47 volumio kernel: ehci-pci 0000:00:1d.0: debug port 2
Jun 25 16:03:47 volumio kernel: ehci-pci 0000:00:1d.0: cache line size of 64 is not supported
Jun 25 16:03:47 volumio kernel: ehci-pci 0000:00:1d.0: irq 23, io mem 0xf7319000
Jun 25 16:03:47 volumio kernel: ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00
Jun 25 16:03:47 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jun 25 16:03:47 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jun 25 16:03:47 volumio kernel: usb usb1: Product: EHCI Host Controller
Jun 25 16:03:47 volumio kernel: usb usb1: Manufacturer: Linux 5.10.176-volumio ehci_hcd
Jun 25 16:03:47 volumio kernel: usb usb1: SerialNumber: 0000:00:1d.0
Jun 25 16:03:47 volumio kernel: hub 1-0:1.0: USB hub found
Jun 25 16:03:47 volumio kernel: hub 1-0:1.0: 2 ports detected
Jun 25 16:03:47 volumio kernel: ehci-platform: EHCI generic platform driver
Jun 25 16:03:47 volumio kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Jun 25 16:03:47 volumio kernel: ohci-pci: OHCI PCI platform driver
Jun 25 16:03:47 volumio kernel: ohci-platform: OHCI generic platform driver
Jun 25 16:03:47 volumio kernel: uhci_hcd: USB Universal Host Controller Interface driver
Jun 25 16:03:47 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller
Jun 25 16:03:47 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2
Jun 25 16:03:47 volumio kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x000000000004b810
Jun 25 16:03:47 volumio kernel: xhci_hcd 0000:00:14.0: cache line size of 64 is not supported
Jun 25 16:03:47 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller
Jun 25 16:03:47 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 3
Jun 25 16:03:47 volumio kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed
Jun 25 16:03:47 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
Jun 25 16:03:47 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jun 25 16:03:47 volumio kernel: usb usb2: Product: xHCI Host Controller
Jun 25 16:03:47 volumio kernel: usb usb2: Manufacturer: Linux 5.10.176-volumio xhci-hcd
Jun 25 16:03:47 volumio kernel: usb usb2: SerialNumber: 0000:00:14.0
Jun 25 16:03:47 volumio kernel: hub 2-0:1.0: USB hub found
Jun 25 16:03:47 volumio kernel: hub 2-0:1.0: 11 ports detected
Jun 25 16:03:47 volumio kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
Jun 25 16:03:47 volumio kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jun 25 16:03:47 volumio kernel: usb usb3: Product: xHCI Host Controller
Jun 25 16:03:47 volumio kernel: usb usb3: Manufacturer: Linux 5.10.176-volumio xhci-hcd
Jun 25 16:03:47 volumio kernel: usb usb3: SerialNumber: 0000:00:14.0
Jun 25 16:03:47 volumio kernel: hub 3-0:1.0: USB hub found
Jun 25 16:03:47 volumio kernel: hub 3-0:1.0: 4 ports detected
Jun 25 16:03:47 volumio kernel: i8042: PNP: No PS/2 controller found.
Jun 25 16:03:47 volumio kernel: mousedev: PS/2 mouse device common for all mice
Jun 25 16:03:47 volumio kernel: rtc_cmos 00:08: RTC can wake from S4
Jun 25 16:03:47 volumio kernel: rtc_cmos 00:08: registered as rtc0
Jun 25 16:03:47 volumio kernel: rtc_cmos 00:08: setting system clock to 2009-01-01T00:00:11 UTC (1230768011)
Jun 25 16:03:47 volumio kernel: rtc_cmos 00:08: alarms up to one month, y3k, 242 bytes nvram
Jun 25 16:03:47 volumio kernel: i2c /dev entries driver
Jun 25 16:03:47 volumio kernel: platform eisa.0: Probing EISA bus 0
Jun 25 16:03:47 volumio kernel: platform eisa.0: EISA: Cannot allocate resource for mainboard
Jun 25 16:03:47 volumio kernel: intel_pstate: Intel P-state driver initializing
Jun 25 16:03:47 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs
Jun 25 16:03:47 volumio kernel: EFI Variables Facility v0.08 2004-May-17
Jun 25 16:03:47 volumio kernel: NET: Registered protocol family 10
Jun 25 16:03:47 volumio kernel: Segment Routing with IPv6
Jun 25 16:03:47 volumio kernel: mip6: Mobile IPv6
Jun 25 16:03:47 volumio kernel: NET: Registered protocol family 17
Jun 25 16:03:47 volumio kernel: mpls_gso: MPLS GSO support
Jun 25 16:03:47 volumio kernel: microcode: sig=0x306d4, pf=0x40, revision=0xa
Jun 25 16:03:47 volumio kernel: microcode: Microcode Update Driver: v2.2.
Jun 25 16:03:47 volumio kernel: IPI shorthand broadcast: enabled
Jun 25 16:03:47 volumio kernel: sched_clock: Marking stable (1236706721, -3734263)->(1236297697, -3325239)
Jun 25 16:03:47 volumio kernel: registered taskstats version 1
Jun 25 16:03:47 volumio kernel: Loading compiled-in X.509 certificates
Jun 25 16:03:47 volumio kernel: zswap: loaded using pool lzo/zbud
Jun 25 16:03:47 volumio kernel: Freeing unused kernel image (initmem) memory: 1820K
Jun 25 16:03:47 volumio kernel: Write protecting the kernel read-only data: 18432k
Jun 25 16:03:47 volumio kernel: Freeing unused kernel image (text/rodata gap) memory: 2036K
Jun 25 16:03:47 volumio kernel: Freeing unused kernel image (rodata/data gap) memory: 1000K
Jun 25 16:03:47 volumio kernel: Run /init as init process
Jun 25 16:03:47 volumio kernel:   with arguments:
Jun 25 16:03:47 volumio kernel:     /init
Jun 25 16:03:47 volumio kernel:     splash
Jun 25 16:03:47 volumio kernel:   with environment:
Jun 25 16:03:47 volumio kernel:     HOME=/
Jun 25 16:03:47 volumio kernel:     TERM=linux
Jun 25 16:03:47 volumio kernel:     BOOT_IMAGE=/vmlinuz
Jun 25 16:03:47 volumio kernel:     biosdevname=0
Jun 25 16:03:47 volumio kernel:     imgpart=UUID=995b3bef-0123-488a-8237-3568c5f00abb
Jun 25 16:03:47 volumio kernel:     bootpart=UUID=5A07-DE33
Jun 25 16:03:47 volumio kernel:     datapart=UUID=12a8ee05-e7f9-406b-97f4-cd5a1b97c8d6
Jun 25 16:03:47 volumio kernel:     imgfile=/volumio_current.sqsh
Jun 25 16:03:47 volumio kernel:     use_kmsg=yes
Jun 25 16:03:47 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jun 25 16:03:47 volumio kernel: fuse: init (API version 7.32)
Jun 25 16:03:47 volumio kernel: sdhci: Secure Digital Host Controller Interface driver
Jun 25 16:03:47 volumio kernel: sdhci: Copyright(c) Pierre Ossman
Jun 25 16:03:47 volumio kernel: hid: raw HID events driver (C) Jiri Kosina
Jun 25 16:03:47 volumio kernel: usbcore: registered new interface driver usbhid
Jun 25 16:03:47 volumio kernel: usbhid: USB HID core driver
Jun 25 16:03:47 volumio kernel: loop: module loaded
Jun 25 16:03:47 volumio kernel: usbcore: registered new interface driver usb-storage
Jun 25 16:03:47 volumio kernel: usb 1-1: new high-speed USB device number 2 using ehci-pci
Jun 25 16:03:47 volumio kernel: usb 2-6: new high-speed USB device number 2 using xhci_hcd
Jun 25 16:03:47 volumio kernel: usb 2-6: New USB device found, idVendor=05e3, idProduct=0608, bcdDevice=60.70
Jun 25 16:03:47 volumio kernel: usb 2-6: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Jun 25 16:03:47 volumio kernel: usb 2-6: Product: USB2.0 Hub
Jun 25 16:03:47 volumio kernel: hub 2-6:1.0: USB hub found
Jun 25 16:03:47 volumio kernel: hub 2-6:1.0: 4 ports detected
Jun 25 16:03:47 volumio kernel: usb 1-1: New USB device found, idVendor=8087, idProduct=8001, bcdDevice= 0.03
Jun 25 16:03:47 volumio kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jun 25 16:03:47 volumio kernel: hub 1-1:1.0: USB hub found
Jun 25 16:03:47 volumio kernel: hub 1-1:1.0: 8 ports detected
Jun 25 16:03:47 volumio kernel: tsc: Refined TSC clocksource calibration: 2294.688 MHz
Jun 25 16:03:47 volumio kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x21139aef754, max_idle_ns: 440795211890 ns
Jun 25 16:03:47 volumio kernel: clocksource: Switched to clocksource tsc
Jun 25 16:03:47 volumio kernel: usb 3-4: new SuperSpeed Gen 1 USB device number 2 using xhci_hcd
Jun 25 16:03:47 volumio kernel: usb 3-4: New USB device found, idVendor=0781, idProduct=5591, bcdDevice= 1.00
Jun 25 16:03:47 volumio kernel: usb 3-4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jun 25 16:03:47 volumio kernel: usb 3-4: Product:  SanDisk 3.2Gen1
Jun 25 16:03:47 volumio kernel: usb 3-4: Manufacturer:  USB
Jun 25 16:03:47 volumio kernel: usb 3-4: SerialNumber: 01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4
Jun 25 16:03:47 volumio kernel: usb-storage 3-4:1.0: USB Mass Storage device detected
Jun 25 16:03:47 volumio kernel: scsi host0: usb-storage 3-4:1.0
Jun 25 16:03:47 volumio kernel: scsi 0:0:0:0: Direct-Access      USB      SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6
Jun 25 16:03:47 volumio kernel: sd 0:0:0:0: [sda] 60125184 512-byte logical blocks: (30.8 GB/28.7 GiB)
Jun 25 16:03:47 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off
Jun 25 16:03:47 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00
Jun 25 16:03:47 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Jun 25 16:03:47 volumio kernel:  sda: sda1 sda2 sda3
Jun 25 16:03:47 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Jun 25 16:03:47 volumio unknown: [i] initramfs: IMGPART=/dev/sda2
Jun 25 16:03:47 volumio unknown: [i] initramfs: IMGFILE=/volumio_current.sqsh
Jun 25 16:03:47 volumio unknown: [i] initramfs: BOOTPART=/dev/sda1
Jun 25 16:03:47 volumio unknown: [i] initramfs: DATAPART=/dev/sda3
Jun 25 16:03:47 volumio kernel: EXT4-fs (sda2): recovery complete
Jun 25 16:03:47 volumio kernel: EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null)
Jun 25 16:03:47 volumio unknown: [i] initramfs: GPTSIZEMISMATCH: 
Jun 25 16:03:47 volumio unknown: [i] initramfs: Doing a 5 second delay here to give kernel load a headstart
Jun 25 16:03:47 volumio unknown: [i] initramfs: Checking for a volumio rootfs update on a USB device
Jun 25 16:03:47 volumio unknown: [i] initramfs: Checking for factory reset on a USB device
Jun 25 16:03:47 volumio unknown: [i] initramfs: Checking for factory or user-data reset on boot device
Jun 25 16:03:47 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jun 25 16:03:47 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jun 25 16:03:47 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jun 25 16:03:47 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jun 25 16:03:47 volumio unknown: [i] initramfs: Volumio version 3.512
Jun 25 16:03:47 volumio kernel: EXT4-fs (sda3): 2 orphan inodes deleted
Jun 25 16:03:47 volumio kernel: EXT4-fs (sda3): recovery complete
Jun 25 16:03:47 volumio kernel: EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null)
Jun 25 16:03:47 volumio kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038 (0x7fffffff)
Jun 25 16:03:47 volumio unknown: [i] initramfs: Checking if fstab needs to be updated..
Jun 25 16:03:47 volumio unknown: [i] initramfs: Current /dev/sda1 - UUID=5A07-DE33
Jun 25 16:03:47 volumio unknown: [i] initramfs: Current fstb \boot
Jun 25 16:03:47 volumio unknown: [i] initramfs: Volumio: 3.512
Jun 25 16:03:47 volumio unknown: [i] initramfs: Finishing initramfs, switching rootfs and starting the boot process...
Jun 25 16:03:47 volumio systemd[1]: System time before build time, advancing clock.
Jun 25 16:03:47 volumio systemd[1]: Inserted module 'autofs4'
Jun 25 16:03:47 volumio systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
Jun 25 16:03:47 volumio systemd[1]: Detected architecture x86-64.
Jun 25 16:03:47 volumio systemd[1]: Set hostname to .
Jun 25 16:03:47 volumio systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling.
Jun 25 16:03:47 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
Jun 25 16:03:47 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jun 25 16:03:47 volumio systemd[1]: Reached target System Time Synchronized.
Jun 25 16:03:47 volumio systemd[1]: Listening on fsck to fsckd communication Socket.
Jun 25 16:03:47 volumio systemd[1]: Created slice system-getty.slice.
Jun 25 16:03:47 volumio systemd[1]: Listening on RPCbind Server Activation Socket.
Jun 25 16:03:47 volumio systemd-journald[226]: Journal started
Jun 25 16:03:47 volumio systemd-journald[226]: Runtime journal (/run/log/journal/c11fdee23ced21dd746a26f464986581) is 7.5M, max 30.0M, 22.5M free.
Jun 25 16:03:47 volumio fake-hwclock[232]: Sun Jun 25 16:03:47 UTC 2023
Jun 25 16:03:47 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown.
Jun 25 16:03:47 volumio systemd[1]: Started Create System Users.
Jun 25 16:03:47 volumio systemd[1]: Starting Create Static Device Nodes in /dev...
Jun 25 16:03:47 volumio systemd[1]: dynamicswap.service: Succeeded.
Jun 25 16:03:47 volumio systemd[1]: Mounted RPC Pipe File System.
Jun 25 16:03:47 volumio kernel: RPC: Registered named UNIX socket transport module.
Jun 25 16:03:47 volumio kernel: RPC: Registered udp transport module.
Jun 25 16:03:47 volumio kernel: RPC: Registered tcp transport module.
Jun 25 16:03:47 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Jun 25 16:03:47 volumio systemd[1]: Started Create Static Device Nodes in /dev.
Jun 25 16:03:47 volumio systemd[1]: Reached target Local File Systems (Pre).
Jun 25 16:03:47 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Jun 25 16:03:47 volumio systemd[1]: Mounting /tmp...
Jun 25 16:03:47 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Jun 25 16:03:47 volumio systemd[1]: Mounting /var/log...
Jun 25 16:03:47 volumio systemd[1]: Mounting /var/spool/cups...
Jun 25 16:03:47 volumio systemd[1]: Starting udev Kernel Device Manager...
Jun 25 16:03:47 volumio systemd[1]: Mounted /tmp.
Jun 25 16:03:47 volumio systemd[1]: Mounted /var/log.
Jun 25 16:03:47 volumio systemd[1]: Mounted /var/spool/cups.
Jun 25 16:03:47 volumio systemd[1]: Mounting /var/spool/cups/tmp...
Jun 25 16:03:47 volumio systemd[1]: Starting Flush Journal to Persistent Storage...
Jun 25 16:03:47 volumio systemd[1]: Mounted /var/spool/cups/tmp.
Jun 25 16:03:47 volumio systemd-udevd[260]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Jun 25 16:03:47 volumio systemd-journald[226]: Runtime journal (/run/log/journal/c11fdee23ced21dd746a26f464986581) is 7.5M, max 30.0M, 22.5M free.
Jun 25 16:03:47 volumio systemd[1]: Started Flush Journal to Persistent Storage.
Jun 25 16:03:47 volumio systemd[1]: Started udev Kernel Device Manager.
Jun 25 16:03:47 volumio systemd[1]: Starting Show Plymouth Boot Screen...
Jun 25 16:03:47 volumio systemd[1]: Received SIGRTMIN+20 from PID 278 (plymouthd).
Jun 25 16:03:47 volumio systemd[1]: Started Show Plymouth Boot Screen.
Jun 25 16:03:47 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Jun 25 16:03:47 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Jun 25 16:03:47 volumio systemd[1]: Reached target Local Encrypted Volumes.
Jun 25 16:03:47 volumio systemd[1]: Reached target Paths.
Jun 25 16:03:47 volumio kernel: i801_smbus 0000:00:1f.3: SPD Write Disable is set
Jun 25 16:03:47 volumio kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
Jun 25 16:03:47 volumio kernel: i2c i2c-0: 1/4 memory slots populated (from DMI)
Jun 25 16:03:47 volumio kernel: i2c i2c-0: Successfully instantiated SPD at 0x50
Jun 25 16:03:47 volumio kernel: pstore: Using crash dump compression: deflate
Jun 25 16:03:47 volumio kernel: pstore: Registered efi as persistent store backend
Jun 25 16:03:47 volumio kernel: igb: Intel(R) Gigabit Ethernet Network Driver
Jun 25 16:03:47 volumio kernel: igb: Copyright (c) 2007-2014 Intel Corporation.
Jun 25 16:03:47 volumio kernel: cryptd: max_cpu_qlen set to 1000
Jun 25 16:03:47 volumio kernel: igb 0000:01:00.0: Intel(R) Gigabit Ethernet Network Connection
Jun 25 16:03:47 volumio kernel: igb 0000:01:00.0: eth0: (PCIe:2.5Gb/s:Width x1) 40:62:31:16:b8:84
Jun 25 16:03:47 volumio kernel: igb 0000:01:00.0: eth0: PBA No: FFFFFF-0FF
Jun 25 16:03:47 volumio kernel: igb 0000:01:00.0: Using MSI-X interrupts. 2 rx queue(s), 2 tx queue(s)
Jun 25 16:03:47 volumio kernel: igb 0000:03:00.0: Intel(R) Gigabit Ethernet Network Connection
Jun 25 16:03:47 volumio kernel: igb 0000:03:00.0: eth1: (PCIe:2.5Gb/s:Width x1) 40:62:31:16:b8:85
Jun 25 16:03:47 volumio kernel: igb 0000:03:00.0: eth1: PBA No: FFFFFF-0FF
Jun 25 16:03:47 volumio kernel: igb 0000:03:00.0: Using MSI-X interrupts. 2 rx queue(s), 2 tx queue(s)
Jun 25 16:03:47 volumio kernel: bcma-pci-bridge 0000:02:00.0: enabling device (0000 -> 0002)
Jun 25 16:03:47 volumio kernel: bcma-pci-bridge 0000:02:00.0: bus0: Found chip with id 43228, rev 0x00 and package 0x08
Jun 25 16:03:47 volumio kernel: bcma-pci-bridge 0000:02:00.0: bus0: Core 0 found: ChipCommon (manuf 0x4BF, id 0x800, rev 0x25, class 0x0)
Jun 25 16:03:47 volumio kernel: bcma-pci-bridge 0000:02:00.0: bus0: Core 1 found: IEEE 802.11 (manuf 0x4BF, id 0x812, rev 0x1E, class 0x0)
Jun 25 16:03:47 volumio kernel: bcma-pci-bridge 0000:02:00.0: bus0: Core 2 found: PCIe (manuf 0x4BF, id 0x820, rev 0x12, class 0x0)
Jun 25 16:03:47 volumio kernel: bcma-pci-bridge 0000:02:00.0: bus0: Core 3 found: SDIO Device (manuf 0x4BF, id 0x829, rev 0x07, class 0x0)
Jun 25 16:03:47 volumio kernel: bcma-pci-bridge 0000:02:00.0: bus0: Bus registered
Jun 25 16:03:47 volumio kernel: usbcore: registered new interface driver uas
Jun 25 16:03:47 volumio kernel: snd_hda_intel 0000:00:03.0: enabling device (0000 -> 0002)
Jun 25 16:03:47 volumio kernel: snd_hda_intel 0000:00:1b.0: enabling device (0000 -> 0002)
Jun 25 16:03:47 volumio kernel: AVX2 version of gcm_enc/dec engaged.
Jun 25 16:03:47 volumio kernel: AES CTR mode by8 optimization enabled
Jun 25 16:03:47 volumio systemd-udevd[268]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jun 25 16:03:47 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Jun 25 16:03:47 volumio systemd-udevd[263]: Using default interface naming scheme 'v240'.
Jun 25 16:03:47 volumio systemd-udevd[277]: Using default interface naming scheme 'v240'.
Jun 25 16:03:47 volumio kernel: at24 0-0050: supply vcc not found, using dummy regulator
Jun 25 16:03:47 volumio kernel: at24 0-0050: 256 byte spd EEPROM, read-only
Jun 25 16:03:47 volumio kernel: snd_hda_codec_realtek hdaudioC1D0: autoconfig for ALC662 rev3: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:line
Jun 25 16:03:47 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
Jun 25 16:03:47 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    hp_outs=1 (0x1b/0x0/0x0/0x0/0x0)
Jun 25 16:03:47 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    mono: mono_out=0x0
Jun 25 16:03:47 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:    inputs:
Jun 25 16:03:47 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:      Front Mic=0x19
Jun 25 16:03:47 volumio kernel: snd_hda_codec_realtek hdaudioC1D0:      Rear Mic=0x18
Jun 25 16:03:47 volumio kernel: input: HDA Intel PCH Front Mic as /devices/pci0000:00/0000:00:1b.0/sound/card1/input3
Jun 25 16:03:47 volumio kernel: input: HDA Intel PCH Rear Mic as /devices/pci0000:00/0000:00:1b.0/sound/card1/input4
Jun 25 16:03:47 volumio kernel: input: HDA Intel PCH Line Out as /devices/pci0000:00/0000:00:1b.0/sound/card1/input5
Jun 25 16:03:47 volumio systemd-udevd[277]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jun 25 16:03:47 volumio systemd[1]: Found device SanDisk_3.2Gen1 boot.
Jun 25 16:03:47 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Jun 25 16:03:47 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Jun 25 16:03:47 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Jun 25 16:03:47 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/5A07-DE33...
Jun 25 16:03:47 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Jun 25 16:03:47 volumio systemd[1]: Started File System Check Daemon to report status.
Jun 25 16:03:47 volumio systemd-fsck[356]: fsck.fat 4.1 (2017-01-24)
Jun 25 16:03:47 volumio systemd-fsck[356]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
Jun 25 16:03:47 volumio systemd-fsck[356]:  Automatically removing dirty bit.
Jun 25 16:03:47 volumio systemd-fsck[356]: Performing changes.
Jun 25 16:03:47 volumio systemd-fsck[356]: /dev/sda1: 20 files, 15674/43727 clusters
Jun 25 16:03:47 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/5A07-DE33.
Jun 25 16:03:47 volumio systemd[1]: Mounting /boot...
Jun 25 16:03:47 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jun 25 16:03:47 volumio systemd-udevd[263]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jun 25 16:03:47 volumio systemd[1]: Mounted /boot.
Jun 25 16:03:47 volumio systemd[1]: Reached target Local File Systems.
Jun 25 16:03:47 volumio systemd[1]: Starting Create Volatile Files and Directories...
Jun 25 16:03:47 volumio systemd[1]: Starting Preprocess NFS configuration...
Jun 25 16:03:47 volumio systemd[1]: Starting Raise network interfaces...
Jun 25 16:03:48 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Jun 25 16:03:48 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Jun 25 16:03:48 volumio systemd[1]: Received SIGRTMIN+20 from PID 278 (plymouthd).
Jun 25 16:03:48 volumio systemd[1]: plymouth-read-write.service: Succeeded.
Jun 25 16:03:48 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Jun 25 16:03:48 volumio systemd[1]: nfs-config.service: Succeeded.
Jun 25 16:03:48 volumio systemd[1]: Started Preprocess NFS configuration.
Jun 25 16:03:48 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Jun 25 16:03:48 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Jun 25 16:03:48 volumio systemd[1]: Reached target NFS client services.
Jun 25 16:03:48 volumio systemd[1]: Started Create Volatile Files and Directories.
Jun 25 16:03:48 volumio systemd[1]: Starting RPC bind portmap service...
Jun 25 16:03:48 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Jun 25 16:03:48 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Jun 25 16:03:48 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Jun 25 16:03:48 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown.
Jun 25 16:03:48 volumio systemd[1]: Reached target System Initialization.
Jun 25 16:03:48 volumio systemd[1]: Listening on mpd.socket.
Jun 25 16:03:48 volumio systemd[1]: Listening on D-Bus System Message Bus Socket.
Jun 25 16:03:48 volumio systemd[1]: Listening on triggerhappy.socket.
Jun 25 16:03:48 volumio systemd[1]: man-db.timer: Not using persistent file timestamp Sun 2023-06-25 16:03:53 UTC as it is in the future.
Jun 25 16:03:48 volumio systemd[1]: Started Daily man-db regeneration.
Jun 25 16:03:48 volumio systemd[1]: Started Daily Cleanup of Temporary Directories.
Jun 25 16:03:48 volumio systemd[1]: apt-daily.timer: Not using persistent file timestamp Sun 2023-06-25 16:03:53 UTC as it is in the future.
Jun 25 16:03:48 volumio systemd[1]: Started Daily apt download activities.
Jun 25 16:03:48 volumio systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Sun 2023-06-25 16:03:53 UTC as it is in the future.
Jun 25 16:03:48 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Jun 25 16:03:48 volumio systemd[1]: Reached target Timers.
Jun 25 16:03:48 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Jun 25 16:03:48 volumio systemd[1]: Reached target Sockets.
Jun 25 16:03:48 volumio systemd[1]: Reached target Basic System.
Jun 25 16:03:48 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Jun 25 16:03:48 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jun 25 16:03:48 volumio systemd[1]: Starting triggerhappy global hotkey daemon...
Jun 25 16:03:48 volumio systemd[1]: Starting Wireless Services...
Jun 25 16:03:48 volumio systemd[1]: Started Volumio Iptables Module.
Jun 25 16:03:48 volumio systemd[1]: Started volumio-remote-updater.service.
Jun 25 16:03:48 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Jun 25 16:03:48 volumio systemd[1]: Starting Login Service...
Jun 25 16:03:48 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Jun 25 16:03:48 volumio systemd[1]: Starting DHCP Client Daemon...
Jun 25 16:03:48 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Jun 25 16:03:48 volumio systemd[1]: Started D-Bus System Message Bus.
Jun 25 16:03:48 volumio systemd[1]: Starting WPA supplicant...
Jun 25 16:03:48 volumio systemd[1]: Started Manage Sound Card State (restore and store).
Jun 25 16:03:48 volumio systemd[1]: Starting Save/Restore Sound Card State...
Jun 25 16:03:48 volumio alsactl[391]: alsactl 1.1.8 daemon started
Jun 25 16:03:48 volumio thd[382]: Unable to parse trigger line:
Jun 25 16:03:48 volumio thd[382]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Jun 25 16:03:48 volumio thd[382]: Unable to parse trigger line:
Jun 25 16:03:48 volumio haveged[380]: haveged: ver: 1.9.1; arch: x86; vend: GenuineIntel; build: (gcc 8.3.0 ITV); collect: 128K
Jun 25 16:03:48 volumio haveged[380]: haveged: cpu: (L4 VC); data: 32K (L4 V); inst: 32K (L4 V); idx: 24/40; sz: 31410/52825
Jun 25 16:03:48 volumio haveged[380]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B):  last entropy estimate 7.99994
Jun 25 16:03:48 volumio haveged[380]: haveged: fills: 0, generated: 0
Jun 25 16:03:48 volumio thd[382]: Found socket passed from systemd
Jun 25 16:03:48 volumio systemd-logind[386]: New seat seat0.
Jun 25 16:03:49 volumio kernel: 8021q: 802.1Q VLAN Support v1.8
Jun 25 16:03:49 volumio systemd-udevd[271]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:49 volumio systemd-logind[386]: Watching system buttons on /dev/input/event1 (Power Button)
Jun 25 16:03:49 volumio systemd-udevd[274]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:49 volumio systemd-logind[386]: Watching system buttons on /dev/input/event0 (Sleep Button)
Jun 25 16:03:49 volumio systemd-udevd[268]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:49 volumio systemd-udevd[272]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:49 volumio systemd-udevd[270]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:49 volumio systemd-logind[386]: Watching system buttons on /dev/input/event2 (Power Button)
Jun 25 16:03:49 volumio systemd-udevd[269]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:49 volumio avahi-daemon[388]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113).
Jun 25 16:03:49 volumio avahi-daemon[388]: Successfully dropped root privileges.
Jun 25 16:03:49 volumio avahi-daemon[388]: avahi-daemon 0.7 starting up.
Jun 25 16:03:49 volumio systemd[1]: Started triggerhappy global hotkey daemon.
Jun 25 16:03:49 volumio avahi-daemon[388]: Successfully called chroot().
Jun 25 16:03:49 volumio avahi-daemon[388]: Successfully dropped remaining capabilities.
Jun 25 16:03:49 volumio avahi-daemon[388]: No service file found in /etc/avahi/services.
Jun 25 16:03:49 volumio avahi-daemon[388]: Network interface enumeration completed.
Jun 25 16:03:49 volumio avahi-daemon[388]: Server startup complete. Host name is volumio.local. Local service cookie is 917791323.
Jun 25 16:03:49 volumio systemd[1]: Started Login Service.
Jun 25 16:03:49 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Jun 25 16:03:49 volumio systemd[1]: Found device I211 Gigabit Network Connection.
Jun 25 16:03:49 volumio systemd[1]: Started ifup for eth0.
Jun 25 16:03:49 volumio systemd[1]: iptables.service: Succeeded.
Jun 25 16:03:50 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jun 25 16:03:50 volumio kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jun 25 16:03:50 volumio ifup[369]: command failed: No such device (-19)
Jun 25 16:03:50 volumio sh[412]: command failed: No such device (-19)
Jun 25 16:03:50 volumio sh[412]: sending commands to master dhcpcd process
Jun 25 16:03:50 volumio dhcpcd[464]: sending commands to master dhcpcd process
Jun 25 16:03:50 volumio ifup[369]: command failed: No such device (-19)
Jun 25 16:03:50 volumio dhcpcd[387]: no interfaces have a carrier
Jun 25 16:03:50 volumio dhcpcd[387]: no interfaces have a carrier
Jun 25 16:03:50 volumio dhcpcd[387]: forked to background, child pid 504
Jun 25 16:03:50 volumio dhcpcd[387]: forked to background, child pid 504
Jun 25 16:03:50 volumio systemd[1]: Started DHCP Client Daemon.
Jun 25 16:03:50 volumio sh[412]: eth0=eth0
Jun 25 16:03:50 volumio dhcpcd[504]: eth0: waiting for carrier
Jun 25 16:03:50 volumio kernel: 8021q: adding VLAN 0 to HW filter on device eth0
Jun 25 16:03:50 volumio dhcpcd[504]: eth1: waiting for carrier
Jun 25 16:03:50 volumio dhcpcd[504]: control command: /sbin/dhcpcd eth0
Jun 25 16:03:50 volumio kernel: 8021q: adding VLAN 0 to HW filter on device eth1
Jun 25 16:03:50 volumio systemd[1]: Started RPC bind portmap service.
Jun 25 16:03:50 volumio systemd[1]: Reached target Remote File Systems (Pre).
Jun 25 16:03:50 volumio systemd[1]: Reached target Remote File Systems.
Jun 25 16:03:50 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Jun 25 16:03:50 volumio systemd[1]: Reached target RPC Port Mapper.
Jun 25 16:03:50 volumio alsactl[391]: No state is present for card PCH
Jun 25 16:03:50 volumio alsactl[391]: Found hardware: "HDA-Intel" "Realtek ALC662 rev3" "HDA:10ec0662,10ec0000,00100300" "0x8086" "0x7270"
Jun 25 16:03:50 volumio alsactl[391]: Hardware is initialized using a generic method
Jun 25 16:03:50 volumio alsactl[391]: No state is present for card PCH
Jun 25 16:03:50 volumio loadcpufreq[512]: Loading cpufreq kernel modules...done (acpi-cpufreq).
Jun 25 16:03:50 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Jun 25 16:03:50 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Jun 25 16:03:50 volumio systemd[1]: Started Raise network interfaces.
Jun 25 16:03:50 volumio alsactl[392]: No state is present for card PCH
Jun 25 16:03:50 volumio alsactl[392]: Found hardware: "HDA-Intel" "Realtek ALC662 rev3" "HDA:10ec0662,10ec0000,00100300" "0x8086" "0x7270"
Jun 25 16:03:50 volumio alsactl[392]: Hardware is initialized using a generic method
Jun 25 16:03:50 volumio alsactl[392]: No state is present for card PCH
Jun 25 16:03:50 volumio cpufrequtils[548]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Jun 25 16:03:50 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters.
Jun 25 16:03:51 volumio systemd-udevd[277]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 1' failed with exit code 99.
Jun 25 16:03:51 volumio systemd[1]: Started Save/Restore Sound Card State.
Jun 25 16:03:51 volumio systemd[1]: Reached target Sound Card.
Jun 25 16:03:51 volumio kernel: checking generic (e0000000 1d5000) vs hw (f6000000 1000000)
Jun 25 16:03:51 volumio kernel: checking generic (e0000000 1d5000) vs hw (e0000000 10000000)
Jun 25 16:03:51 volumio kernel: fb0: switching to inteldrmfb from simple
Jun 25 16:03:51 volumio kernel: Console: switching to colour dummy device 80x25
Jun 25 16:03:51 volumio kernel: i915 0000:00:02.0: vgaarb: deactivate vga console
Jun 25 16:03:51 volumio kernel: i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem
Jun 25 16:03:51 volumio kernel: i915 0000:00:02.0: [drm] failed to retrieve link info, disabling eDP
Jun 25 16:03:51 volumio kernel: [drm] Initialized i915 1.6.0 20200917 for 0000:00:02.0 on minor 0
Jun 25 16:03:51 volumio kernel: ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
Jun 25 16:03:51 volumio kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input6
Jun 25 16:03:51 volumio kernel: snd_hda_intel 0000:00:03.0: bound 0000:00:02.0 (ops intel_plane_helper_funcs [i915])
Jun 25 16:03:51 volumio kernel: fbcon: i915drmfb (fb0) is primary device
Jun 25 16:03:51 volumio kernel: Console: switching to colour frame buffer device 240x67
Jun 25 16:03:51 volumio kernel: i915 0000:00:02.0: [drm] fb0: i915drmfb frame buffer device
Jun 25 16:03:51 volumio systemd-udevd[270]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:51 volumio kernel: input: HDA Intel HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:03.0/sound/card0/input7
Jun 25 16:03:51 volumio kernel: input: HDA Intel HDMI HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:03.0/sound/card0/input8
Jun 25 16:03:51 volumio kernel: input: HDA Intel HDMI HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:03.0/sound/card0/input9
Jun 25 16:03:51 volumio kernel: input: HDA Intel HDMI HDMI/DP,pcm=9 as /devices/pci0000:00/0000:00:03.0/sound/card0/input10
Jun 25 16:03:51 volumio kernel: input: HDA Intel HDMI HDMI/DP,pcm=10 as /devices/pci0000:00/0000:00:03.0/sound/card0/input11
Jun 25 16:03:51 volumio systemd-udevd[272]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 99.
Jun 25 16:03:51 volumio systemd-udevd[269]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:51 volumio systemd-udevd[270]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:51 volumio systemd-udevd[273]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:51 volumio systemd-udevd[263]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:51 volumio systemd-udevd[267]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:03:51 volumio systemd[1]: Started WPA supplicant.
Jun 25 16:03:51 volumio wpa_supplicant[390]: Successfully initialized wpa_supplicant
Jun 25 16:03:51 volumio systemd[1]: Reached target Network.
Jun 25 16:03:51 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Jun 25 16:03:51 volumio systemd[1]: Starting Music Player Daemon...
Jun 25 16:03:51 volumio systemd[1]: Reached target Network is Online.
Jun 25 16:03:51 volumio systemd[1]: Starting /etc/rc.local Compatibility...
Jun 25 16:03:51 volumio systemd[1]: Starting LSB: Brings up/down network automatically...
Jun 25 16:03:51 volumio systemd[1]: Starting Network Time Service...
Jun 25 16:03:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 25 16:03:51 volumio systemd[1]: Starting Permit User Sessions...
Jun 25 16:03:51 volumio systemd[1]: Starting Samba NMB Daemon...
Jun 25 16:03:51 volumio systemd[1]: Started /etc/rc.local Compatibility.
Jun 25 16:03:51 volumio systemd[1]: Started Permit User Sessions.
Jun 25 16:03:51 volumio systemd[1]: Starting Terminate Plymouth Boot Screen...
Jun 25 16:03:51 volumio systemd[1]: Starting Hold until boot process finishes up...
Jun 25 16:03:52 volumio ntpd[614]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jun 25 16:03:52 volumio ntpd[614]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Jun 25 16:03:52 volumio systemd[1]: Started Network Time Service.
Jun 25 16:03:52 volumio ntpd[632]: proto: precision = 0.103 usec (-23)
Jun 25 16:03:52 volumio ntpd[632]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jun 25 16:03:52 volumio ntpd[632]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jun 25 16:03:52 volumio ntpd[632]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 180 days ago
Jun 25 16:03:52 volumio ntpd[632]: Listen and drop on 0 v6wildcard [::]:123
Jun 25 16:03:52 volumio ntpd[632]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jun 25 16:03:52 volumio ntpd[632]: Listen normally on 2 lo 127.0.0.1:123
Jun 25 16:03:52 volumio ntpd[632]: Listening on routing socket on fd #19 for interface updates
Jun 25 16:03:52 volumio ntpd[632]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jun 25 16:03:52 volumio ntpd[632]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jun 25 16:03:52 volumio kernel: b43-phy0: Broadcom 43228 WLAN found (core revision 30)
Jun 25 16:03:52 volumio kernel: b43-phy0: Found PHY: Analog 9, Type 4 (N), Revision 16
Jun 25 16:03:52 volumio kernel: b43-phy0: Found Radio: Manuf 0x17F, ID 0x2057, Revision 9, Version 1
Jun 25 16:03:52 volumio kernel: Broadcom 43xx driver loaded [ Features: PNLS ]
Jun 25 16:03:53 volumio systemd-udevd[270]: Using default interface naming scheme 'v240'.
Jun 25 16:03:53 volumio systemd[1]: Starting Load/Save RF Kill Switch Status...
Jun 25 16:03:53 volumio kernel: ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
Jun 25 16:03:53 volumio systemd[1]: Started Load/Save RF Kill Switch Status.
Jun 25 16:03:53 volumio volumio-remote-updater[385]: Error: No active session
Jun 25 16:03:53 volumio kernel: b43-phy0: Loading firmware version 666.2 (2011-02-23 01:15:07)
Jun 25 16:03:53 volumio kernel: igb 0000:03:00.0 eth1: igb: eth1 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX
Jun 25 16:03:53 volumio dhcpcd[504]: wlan0: waiting for carrier
Jun 25 16:03:53 volumio dhcpcd[504]: wlan0: carrier acquired
Jun 25 16:03:53 volumio systemd-udevd[270]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jun 25 16:03:53 volumio volumio-remote-updater[385]: [2023-06-25 16:03:53] [info] asio async_connect error: system:111 (Connection refused)
Jun 25 16:03:53 volumio volumio-remote-updater[385]: [2023-06-25 16:03:53] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jun 25 16:03:53 volumio dhcpcd[504]: DUID 00:04:03:00:02:00:04:00:05:00:00:06:00:07:00:08:00:09
Jun 25 16:03:53 volumio dhcpcd[504]: wlan0: IAID 87:5f:d8:64
Jun 25 16:03:53 volumio dhcpcd[504]: wlan0: adding address fe80::5e07:1534:89fe:442e
Jun 25 16:03:53 volumio dhcpcd[504]: ipv6_addaddr1: Permission denied
Jun 25 16:03:53 volumio dhcpcd[504]: wlan0: carrier lost
Jun 25 16:03:53 volumio systemd[1]: Found device BCM43228 802.11a/b/g/n (BCM943228HM4L 802.11a/b/g/n 2x2 Wi-Fi Adapter).
Jun 25 16:03:53 volumio systemd[1]: Started ifup for wlan0.
Jun 25 16:03:53 volumio dhcpcd[504]: eth1: carrier acquired
Jun 25 16:03:53 volumio dhcpcd[504]: eth1: IAID 31:16:b8:85
Jun 25 16:03:53 volumio dhcpcd[504]: eth1: adding address fe80::3f32:b4f:3d07:8d3d
Jun 25 16:03:53 volumio dhcpcd[504]: ipv6_addaddr1: Permission denied
Jun 25 16:03:53 volumio volumio-remote-updater[385]: [2023-06-25 16:03:53] [error] handle_connect error: Underlying Transport Error
Jun 25 16:03:53 volumio sh[667]: wlan0=wlan0
Jun 25 16:03:53 volumio dhcpcd[504]: eth1: soliciting an IPv6 router
Jun 25 16:03:53 volumio ntpd[632]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Jun 25 16:03:53 volumio volumio[381]: Could not open config: /tmp/upmpdcli.conf
Jun 25 16:03:54 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Jun 25 16:03:54 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Jun 25 16:03:54 volumio dhcpcd[504]: eth1: rebinding lease of 192.168.1.19
Jun 25 16:03:54 volumio dhcpcd[504]: eth1: probing address 192.168.1.19/24
Jun 25 16:03:54 volumio ntpd[632]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Jun 25 16:03:54 volumio nmbd[619]: [2023/06/25 16:03:54.660749,  0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Jun 25 16:03:54 volumio nmbd[619]:   started asyncdns process 711
Jun 25 16:03:54 volumio nmbd[619]: [2023/06/25 16:03:54.661579,  0] ../lib/util/become_daemon.c:149(daemon_status)
Jun 25 16:03:54 volumio nmbd[619]:   daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Jun 25 16:03:54 volumio nmbd[619]: [2023/06/25 16:03:54.661632,  0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Jun 25 16:03:54 volumio nmbd[619]:   NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Jun 25 16:03:54 volumio systemd[1]: Received SIGRTMIN+21 from PID 278 (plymouthd).
Jun 25 16:03:54 volumio systemd[1]: Received SIGRTMIN+21 from PID 278 (plymouthd).
Jun 25 16:03:54 volumio ifplugd[613]: Network Interface Plugging Daemon...error: unexpectedly disconnected from boot status daemon
Jun 25 16:03:54 volumio systemd[1]: plymouth-quit.service: Succeeded.
Jun 25 16:03:54 volumio systemd[1]: Started Terminate Plymouth Boot Screen.
Jun 25 16:03:54 volumio systemd[1]: plymouth-quit-wait.service: Succeeded.
Jun 25 16:03:54 volumio systemd[1]: Started Hold until boot process finishes up.
Jun 25 16:03:54 volumio systemd[1]: Started Getty on tty1.
Jun 25 16:03:54 volumio systemd[1]: Reached target Login Prompts.
Jun 25 16:03:54 volumio ifplugd(eth0)[721]: ifplugd 0.28 initializing.
Jun 25 16:03:54 volumio ifplugd(eth0)[721]: Using interface eth0/40:62:31:16:B8:84 with driver  (version: 5.10.176-volumio)
Jun 25 16:03:54 volumio ifplugd(eth0)[721]: Using detection mode: SIOCETHTOOL
Jun 25 16:03:54 volumio ifplugd(eth0)[721]: Initialization complete, link beat not detected.
Jun 25 16:03:54 volumio systemd[1]: plymouth-start.service: Succeeded.
Jun 25 16:03:54 volumio ifplugd[613]: start eth0...done.
Jun 25 16:03:54 volumio systemd[1]: Started LSB: Brings up/down network automatically.
Jun 25 16:03:55 volumio wireless.js[383]: Cleaning previous...
Jun 25 16:03:55 volumio sudo[735]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Jun 25 16:03:55 volumio sudo[735]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:55 volumio sudo[735]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:55 volumio sudo[737]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Jun 25 16:03:55 volumio sudo[737]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:55 volumio mpd[629]: exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 25 16:03:55 volumio mpd[629]: config: Found database setting without music_directory - disabling database
Jun 25 16:03:55 volumio mpd[629]: output: No 'audio_output' defined in config file
Jun 25 16:03:55 volumio mpd[629]: output: Attempt to detect audio output device
Jun 25 16:03:55 volumio mpd[629]: output: Attempting to detect a alsa audio device
Jun 25 16:03:55 volumio mpd[629]: ALSA lib pcm_dmix.c:1108:(snd_pcm_dmix_open) unable to open slave
Jun 25 16:03:55 volumio mpd[629]: alsa_output: Error opening default ALSA device: No such file or directory
Jun 25 16:03:55 volumio mpd[629]: output: Attempting to detect a oss audio device
Jun 25 16:03:55 volumio mpd[629]: oss_output: Error opening OSS device "/dev/dsp": No such file or directory
Jun 25 16:03:55 volumio mpd[629]: oss_output: Error opening OSS device "/dev/sound/dsp": No such file or directory
Jun 25 16:03:55 volumio mpd[629]: output: Attempting to detect a pulse audio device
Jun 25 16:03:55 volumio mpd[629]: output: Attempting to detect a jack audio device
Jun 25 16:03:55 volumio mpd[629]: output: Successfully detected a jack audio device
Jun 25 16:03:55 volumio mpd[629]: exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jun 25 16:03:55 volumio mpd[629]: exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jun 25 16:03:55 volumio sudo[737]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:55 volumio mpd[629]: zeroconf: No global port, disabling zeroconf
Jun 25 16:03:55 volumio systemd[1]: Started Music Player Daemon.
Jun 25 16:03:55 volumio wireless.js[383]: Stopped aP
Jun 25 16:03:55 volumio sudo[747]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jun 25 16:03:55 volumio sudo[747]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:55 volumio ntpd[632]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Jun 25 16:03:55 volumio kernel: b43-phy0: Loading firmware version 666.2 (2011-02-23 01:15:07)
Jun 25 16:03:55 volumio sudo[747]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:55 volumio sudo[750]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Jun 25 16:03:55 volumio sudo[750]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:55 volumio sudo[750]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:55 volumio sudo[757]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jun 25 16:03:55 volumio sudo[757]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:55 volumio sudo[757]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:55 volumio sudo[759]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Jun 25 16:03:55 volumio sudo[759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:56 volumio ntpd[632]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Jun 25 16:03:57 volumio sudo[759]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:57 volumio sudo[766]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Jun 25 16:03:57 volumio sudo[766]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:57 volumio sudo[766]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:57 volumio sudo[768]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Jun 25 16:03:57 volumio sudo[768]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:03:57 volumio sudo[768]: pam_unix(sudo:session): session closed for user root
Jun 25 16:03:57 volumio kernel: b43-phy0: Loading firmware version 666.2 (2011-02-23 01:15:07)
Jun 25 16:03:57 volumio avahi-daemon[388]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1.
Jun 25 16:03:57 volumio avahi-daemon[388]: New relevant interface wlan0.IPv4 for mDNS.
Jun 25 16:03:57 volumio avahi-daemon[388]: Registering new address record for 192.168.211.1 on wlan0.IPv4.
Jun 25 16:03:57 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator...
Jun 25 16:03:58 volumio hostapd[775]: Configuration file: /etc/hostapd/hostapd.conf
Jun 25 16:03:58 volumio systemd[1]: systemd-rfkill.service: Succeeded.
Jun 25 16:03:58 volumio avahi-daemon[388]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jun 25 16:03:58 volumio avahi-daemon[388]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1.
Jun 25 16:03:58 volumio kernel: b43-phy0: Loading firmware version 666.2 (2011-02-23 01:15:07)
Jun 25 16:03:58 volumio avahi-daemon[388]: Withdrawing address record for 192.168.211.1 on wlan0.
Jun 25 16:03:58 volumio avahi-daemon[388]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1.
Jun 25 16:03:58 volumio avahi-daemon[388]: New relevant interface wlan0.IPv4 for mDNS.
Jun 25 16:03:58 volumio avahi-daemon[388]: Registering new address record for 192.168.211.1 on wlan0.IPv4.
Jun 25 16:03:58 volumio hostapd[775]: Using interface wlan0 with hwaddr 34:23:87:5f:d8:64 and ssid "Volumio-0186A"
Jun 25 16:03:58 volumio dhcpcd[504]: wlan0: carrier acquired
Jun 25 16:03:58 volumio hostapd[775]: wlan0: interface state UNINITIALIZED->ENABLED
Jun 25 16:03:58 volumio hostapd[775]: wlan0: AP-ENABLED
Jun 25 16:03:58 volumio systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator.
Jun 25 16:03:58 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server...
Jun 25 16:03:58 volumio volumio-remote-updater[385]: [2023-06-25 16:03:58] [info] asio async_connect error: system:111 (Connection refused)
Jun 25 16:03:58 volumio volumio-remote-updater[385]: [2023-06-25 16:03:58] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jun 25 16:03:58 volumio volumio-remote-updater[385]: [2023-06-25 16:03:58] [error] handle_connect error: Underlying Transport Error
Jun 25 16:03:58 volumio iwconfig[780]: Error for wireless request "Set Power Management" (8B2C) :
Jun 25 16:03:58 volumio iwconfig[780]:     SET failed on device wlan0 ; Invalid argument.
Jun 25 16:03:58 volumio dnsmasq[778]: dnsmasq: syntax check OK.
Jun 25 16:03:58 volumio systemd[1]: wireless.service: Succeeded.
Jun 25 16:03:58 volumio systemd[1]: Started Wireless Services.
Jun 25 16:03:58 volumio systemd[1]: Started Volumio Backend Module.
Jun 25 16:03:58 volumio systemd[1]: Started Start Volumio Kiosk.
Jun 25 16:03:58 volumio systemd[1]: Started Intel SST and HDA soundcard init service.
Jun 25 16:03:58 volumio dhcpcd[504]: wlan0: IAID 87:5f:d8:64
Jun 25 16:03:58 volumio dnsmasq[816]: started, version 2.80 cachesize 150
Jun 25 16:03:58 volumio dnsmasq[816]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile
Jun 25 16:03:58 volumio dnsmasq-dhcp[816]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d
Jun 25 16:03:58 volumio dnsmasq[816]: reading /etc/resolv.conf
Jun 25 16:03:58 volumio dnsmasq[816]: using nameserver 208.67.222.222#53
Jun 25 16:03:58 volumio dnsmasq[816]: using nameserver 208.67.220.220#53
Jun 25 16:03:58 volumio dnsmasq[816]: read /etc/hosts - 5 addresses
Jun 25 16:03:58 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server.
Jun 25 16:03:58 volumio systemd[1]: Reached target Host and Network Name Lookups.
Jun 25 16:03:58 volumio startx[783]: X.Org X Server 1.20.4
Jun 25 16:03:58 volumio startx[783]: X Protocol Version 11, Revision 0
Jun 25 16:03:58 volumio startx[783]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian
Jun 25 16:03:58 volumio startx[783]: Current Operating System: Linux volumio 5.10.176-volumio #1 SMP Thu Mar 30 17:57:37 CEST 2023 x86_64
Jun 25 16:03:58 volumio startx[783]: Kernel command line: BOOT_IMAGE=/vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=995b3bef-0123-488a-8237-3568c5f00abb bootpart=UUID=5A07-DE33 datapart=UUID=12a8ee05-e7f9-406b-97f4-cd5a1b97c8d6 imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0
Jun 25 16:03:58 volumio startx[783]: Build Date: 18 December 2021  09:05:36AM
Jun 25 16:03:58 volumio startx[783]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support)
Jun 25 16:03:58 volumio startx[783]: Current version of pixman: 0.36.0
Jun 25 16:03:58 volumio startx[783]:         Before reporting problems, check http://wiki.x.org
Jun 25 16:03:58 volumio startx[783]:         to make sure that you have the latest version.
Jun 25 16:03:58 volumio startx[783]: Markers: (--) probed, (**) from config file, (==) default setting,
Jun 25 16:03:58 volumio startx[783]:         (++) from command line, (!!) notice, (II) informational,
Jun 25 16:03:58 volumio startx[783]:         (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jun 25 16:03:58 volumio startx[783]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Jun 25 16:03:58 2023
Jun 25 16:03:58 volumio startx[783]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jun 25 16:03:58 volumio dhcpcd[504]: wlan0: soliciting an IPv6 router
Jun 25 16:03:58 volumio systemd[1]: soundcard-init.service: Succeeded.
Jun 25 16:03:58 volumio kernel: broken atomic modeset userspace detected, disabling atomic
Jun 25 16:03:59 volumio startx[783]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc.
Jun 25 16:03:59 volumio dhcpcd[504]: wlan0: soliciting a DHCP lease
Jun 25 16:03:59 volumio volumio[782]: info: -------------------------------------------
Jun 25 16:03:59 volumio volumio[782]: info: -----            Volumio3              ----
Jun 25 16:03:59 volumio volumio[782]: info: -------------------------------------------
Jun 25 16:03:59 volumio volumio[782]: info: -----          System startup          ----
Jun 25 16:03:59 volumio volumio[782]: info: -------------------------------------------
Jun 25 16:03:59 volumio ntpd[632]: Listen normally on 3 wlan0 192.168.211.1:123
Jun 25 16:03:59 volumio ntpd[632]: new interface(s) found: waking up resolver
Jun 25 16:03:59 volumio nmbd[619]: [2023/06/25 16:03:59.669134,  0] ../lib/util/become_daemon.c:138(daemon_ready)
Jun 25 16:03:59 volumio nmbd[619]:   daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Jun 25 16:03:59 volumio systemd[1]: Started Samba NMB Daemon.
Jun 25 16:03:59 volumio systemd[1]: Starting Samba Winbind Daemon...
Jun 25 16:03:59 volumio dhcpcd[504]: eth1: leased 192.168.1.19 for 86400 seconds
Jun 25 16:03:59 volumio avahi-daemon[388]: Joining mDNS multicast group on interface eth1.IPv4 with address 192.168.1.19.
Jun 25 16:03:59 volumio dhcpcd[504]: eth1: adding route to 192.168.1.0/24
Jun 25 16:03:59 volumio avahi-daemon[388]: New relevant interface eth1.IPv4 for mDNS.
Jun 25 16:03:59 volumio avahi-daemon[388]: Registering new address record for 192.168.1.19 on eth1.IPv4.
Jun 25 16:03:59 volumio dhcpcd[504]: eth1: adding default route via 192.168.1.1
Jun 25 16:03:59 volumio dnsmasq[816]: reading /etc/resolv.conf
Jun 25 16:03:59 volumio dnsmasq[816]: using nameserver 8.8.8.8#53
Jun 25 16:03:59 volumio dnsmasq[816]: using nameserver 8.8.4.4#53
Jun 25 16:03:59 volumio dnsmasq[816]: using nameserver 208.67.222.222#53
Jun 25 16:03:59 volumio dnsmasq[816]: using nameserver 208.67.220.220#53
Jun 25 16:03:59 volumio ntpd[632]: ntpd exiting on signal 15 (Terminated)
Jun 25 16:03:59 volumio systemd[1]: Stopping Network Time Service...
Jun 25 16:03:59 volumio systemd[1]: ntp.service: Succeeded.
Jun 25 16:03:59 volumio systemd[1]: Stopped Network Time Service.
Jun 25 16:03:59 volumio systemd[1]: Starting Network Time Service...
Jun 25 16:03:59 volumio ntpd[990]: ntpd 4.2.8p12@1.3728-o (1): Starting
Jun 25 16:03:59 volumio systemd[1]: Started Network Time Service.
Jun 25 16:03:59 volumio ntpd[990]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Jun 25 16:03:59 volumio ntpd[996]: proto: precision = 0.096 usec (-23)
Jun 25 16:03:59 volumio ntpd[996]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Jun 25 16:03:59 volumio ntpd[996]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Jun 25 16:03:59 volumio ntpd[996]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 180 days ago
Jun 25 16:03:59 volumio ntpd[996]: Listen and drop on 0 v6wildcard [::]:123
Jun 25 16:03:59 volumio ntpd[996]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jun 25 16:03:59 volumio ntpd[996]: Listen normally on 2 lo 127.0.0.1:123
Jun 25 16:03:59 volumio ntpd[996]: Listen normally on 3 eth1 192.168.1.19:123
Jun 25 16:03:59 volumio ntpd[996]: Listen normally on 4 wlan0 192.168.211.1:123
Jun 25 16:03:59 volumio ntpd[996]: Listening on routing socket on fd #21 for interface updates
Jun 25 16:03:59 volumio ntpd[996]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jun 25 16:03:59 volumio ntpd[996]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Jun 25 16:03:59 volumio winbindd[954]: [2023/06/25 16:03:59.942940,  0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Jun 25 16:03:59 volumio winbindd[954]:   initialize_winbindd_cache: clearing cache and re-creating with version number 2
Jun 25 16:04:00 volumio winbindd[954]: [2023/06/25 16:04:00.010609,  0] ../lib/util/become_daemon.c:138(daemon_ready)
Jun 25 16:04:00 volumio winbindd[954]:   daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Jun 25 16:04:00 volumio systemd[1]: Started Samba Winbind Daemon.
Jun 25 16:04:00 volumio systemd[1]: Starting Samba SMB Daemon...
Jun 25 16:04:00 volumio smbd[1001]: [2023/06/25 16:04:00.490138,  0] ../lib/util/become_daemon.c:138(daemon_ready)
Jun 25 16:04:00 volumio smbd[1001]:   daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Jun 25 16:04:00 volumio systemd[1]: Started Samba SMB Daemon.
Jun 25 16:04:00 volumio systemd[1]: Reached target Multi-User System.
Jun 25 16:04:00 volumio systemd[1]: Reached target Graphical Interface.
Jun 25 16:04:00 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jun 25 16:04:00 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jun 25 16:04:00 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Jun 25 16:04:00 volumio systemd[1]: Startup finished in 9.431s (firmware) + 5.278s (loader) + 15.462s (kernel) + 13.904s (userspace) = 44.076s.
Jun 25 16:04:00 volumio ntpd[996]: Soliciting pool server 103.72.56.71
Jun 25 16:04:01 volumio volumio[782]: info: MYVOLUMIO Environment detected
Jun 25 16:04:01 volumio volumio[782]: info: Plugin folders cleanup
Jun 25 16:04:01 volumio volumio[782]: info: Scanning into folder /volumio/app/plugins/
Jun 25 16:04:01 volumio volumio[782]: info: Scanning category audio_interface
Jun 25 16:04:01 volumio volumio[782]: info: Scanning category miscellanea
Jun 25 16:04:01 volumio volumio[782]: info: Scanning category music_service
Jun 25 16:04:01 volumio volumio[782]: info: Scanning category plugins.json
Jun 25 16:04:01 volumio volumio[782]: info: Scanning category system_controller
Jun 25 16:04:01 volumio volumio[782]: info: Scanning category user_interface
Jun 25 16:04:01 volumio volumio[782]: info: Scanning into folder /data/plugins/
Jun 25 16:04:01 volumio volumio[782]: info: Plugin folders cleanup completed
Jun 25 16:04:01 volumio volumio[782]: info: -------------------------------------------
Jun 25 16:04:01 volumio volumio[782]: info: -----      Core plugins startup        ----
Jun 25 16:04:01 volumio volumio[782]: info: -------------------------------------------
Jun 25 16:04:01 volumio volumio[782]: info: Loading plugins from folder /volumio/app/plugins/
Jun 25 16:04:01 volumio volumio[782]: info: Adding plugin upnp to MyMusic Plugins
Jun 25 16:04:01 volumio volumio[782]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 25 16:04:01 volumio volumio[782]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 25 16:04:01 volumio volumio[782]: info: Loading plugins from folder /data/plugins/
Jun 25 16:04:01 volumio volumio[782]: info: Loading plugin "system"...
Jun 25 16:04:01 volumio volumio[782]: info: Loading plugin "appearance"...
Jun 25 16:04:01 volumio ntpd[996]: Soliciting pool server 45.252.250.189
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "network"...
Jun 25 16:04:02 volumio volumio[782]: info: Refreshing Cached IP Addresses
Jun 25 16:04:02 volumio sudo[1054]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 25 16:04:02 volumio sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:02 volumio sudo[1054]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "services"...
Jun 25 16:04:02 volumio sudo[1057]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 25 16:04:02 volumio sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "alsa_controller"...
Jun 25 16:04:02 volumio sudo[1057]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:02 volumio sudo[1059]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 25 16:04:02 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:02 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:02 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "wizard"...
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "volumio_command_line_client"...
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "upnp"...
Jun 25 16:04:02 volumio volumio[782]: info: [1687709042094] Starting Upmpd Daemon
Jun 25 16:04:02 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "my_music"...
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "mpd"...
Jun 25 16:04:02 volumio volumio[782]: info: Creating MPD Configuration file
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "upnp_browser"...
Jun 25 16:04:02 volumio sudo[1067]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 25 16:04:02 volumio sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:02 volumio sudo[1067]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:02 volumio sudo[1069]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 25 16:04:02 volumio sudo[1069]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:02 volumio systemd[1]: Stopping Music Player Daemon...
Jun 25 16:04:02 volumio systemd[1]: mpd.service: Succeeded.
Jun 25 16:04:02 volumio systemd[1]: Stopped Music Player Daemon.
Jun 25 16:04:02 volumio systemd[1]: Starting Music Player Daemon...
Jun 25 16:04:02 volumio volumio[782]: info: Loading plugin "networkfs"...
Jun 25 16:04:02 volumio mpd[1074]: exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 25 16:04:02 volumio mpd[1074]: config: Found database setting without music_directory - disabling database
Jun 25 16:04:02 volumio mpd[1074]: output: No 'audio_output' defined in config file
Jun 25 16:04:02 volumio mpd[1074]: output: Attempt to detect audio output device
Jun 25 16:04:02 volumio mpd[1074]: output: Attempting to detect a alsa audio device
Jun 25 16:04:02 volumio mpd[1074]: ALSA lib pcm_dmix.c:1108:(snd_pcm_dmix_open) unable to open slave
Jun 25 16:04:02 volumio mpd[1074]: alsa_output: Error opening default ALSA device: No such file or directory
Jun 25 16:04:02 volumio mpd[1074]: output: Attempting to detect a oss audio device
Jun 25 16:04:02 volumio mpd[1074]: oss_output: Error opening OSS device "/dev/dsp": No such file or directory
Jun 25 16:04:02 volumio mpd[1074]: oss_output: Error opening OSS device "/dev/sound/dsp": No such file or directory
Jun 25 16:04:02 volumio mpd[1074]: output: Attempting to detect a pulse audio device
Jun 25 16:04:02 volumio mpd[1074]: output: Attempting to detect a jack audio device
Jun 25 16:04:02 volumio mpd[1074]: output: Successfully detected a jack audio device
Jun 25 16:04:02 volumio mpd[1074]: exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jun 25 16:04:02 volumio mpd[1074]: exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jun 25 16:04:02 volumio mpd[1074]: zeroconf: No global port, disabling zeroconf
Jun 25 16:04:02 volumio systemd[1]: Started Music Player Daemon.
Jun 25 16:04:02 volumio sudo[1069]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:02 volumio volumio[782]: info: Starting Udev Watcher for removable devices
Jun 25 16:04:03 volumio volumio[782]: info: Ignoring mount for partition: boot
Jun 25 16:04:03 volumio volumio[782]: info: Ignoring mount for partition: volumio
Jun 25 16:04:03 volumio volumio[782]: info: Ignoring mount for partition: volumio_data
Jun 25 16:04:03 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "alarm-clock"...
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "airplay_emulation"...
Jun 25 16:04:03 volumio volumio[782]: info: Starting Shairport Sync
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "last_100"...
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "webradio"...
Jun 25 16:04:03 volumio ntpd[996]: Soliciting pool server 115.165.161.155
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "i2s_dacs"...
Jun 25 16:04:03 volumio volumio[782]: info: I2S DAC not set, start Auto-detection
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "volumiodiscovery"...
Jun 25 16:04:03 volumio volumio[782]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 25 16:04:03 volumio volumio[782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 25 16:04:03 volumio volumio[782]: *** WARNING *** For more information see 
Jun 25 16:04:03 volumio node[782]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 25 16:04:03 volumio volumio[782]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 25 16:04:03 volumio volumio[782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 25 16:04:03 volumio volumio[782]: *** WARNING *** For more information see 
Jun 25 16:04:03 volumio node[782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 25 16:04:03 volumio node[782]: *** WARNING *** For more information see 
Jun 25 16:04:03 volumio node[782]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 25 16:04:03 volumio node[782]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 25 16:04:03 volumio node[782]: *** WARNING *** For more information see 
Jun 25 16:04:03 volumio volumio[782]: info: Discovery: Started advertising with name: Volumio
Jun 25 16:04:03 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "outputs"...
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "albumart"...
Jun 25 16:04:03 volumio volumio[782]: info: Plugin example_plugin is not enabled
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "inputs"...
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "updater_comm"...
Jun 25 16:04:03 volumio volumio[782]: Forking 3 albumart workers
Jun 25 16:04:03 volumio volumio[782]: info: Plugin mpdemulation is not enabled
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "rest_api"...
Jun 25 16:04:03 volumio dbus-daemon[389]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.9' (uid=0 pid=1022 comm="/usr/lib/chromium/chromium --show-component-extens")
Jun 25 16:04:03 volumio systemd[1]: Starting Bluetooth service...
Jun 25 16:04:03 volumio volumio[782]: info: Loading plugin "websocket"...
Jun 25 16:04:03 volumio volumio[782]: info: Loading i18n strings for locale en
Jun 25 16:04:03 volumio volumio[782]: Updating browse sources language
Jun 25 16:04:03 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 25 16:04:03 volumio volumio[782]: Starting albumart workers
Jun 25 16:04:03 volumio volumio[782]: Starting albumart workers
Jun 25 16:04:03 volumio volumio[782]: Starting albumart workers
Jun 25 16:04:03 volumio bluetoothd[1123]: Bluetooth daemon 5.50
Jun 25 16:04:03 volumio kernel: Bluetooth: Core ver 2.22
Jun 25 16:04:03 volumio kernel: NET: Registered protocol family 31
Jun 25 16:04:03 volumio kernel: Bluetooth: HCI device and connection manager initialized
Jun 25 16:04:03 volumio kernel: Bluetooth: HCI socket layer initialized
Jun 25 16:04:03 volumio kernel: Bluetooth: L2CAP socket layer initialized
Jun 25 16:04:03 volumio kernel: Bluetooth: SCO socket layer initialized
Jun 25 16:04:03 volumio bluetoothd[1123]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Jun 25 16:04:03 volumio dbus-daemon[389]: [system] Successfully activated service 'org.bluez'
Jun 25 16:04:03 volumio systemd[1]: Started Bluetooth service.
Jun 25 16:04:03 volumio bluetoothd[1123]: Starting SDP server
Jun 25 16:04:03 volumio bluetoothd[1123]: Excluding (cli) sap
Jun 25 16:04:03 volumio bluetoothd[1123]: Bluetooth management interface 1.18 initialized
Jun 25 16:04:03 volumio dbus-daemon[389]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.10' (uid=0 pid=1123 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Jun 25 16:04:03 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Jun 25 16:04:03 volumio kernel: Bluetooth: BNEP filters: protocol multicast
Jun 25 16:04:03 volumio kernel: Bluetooth: BNEP socket layer initialized
Jun 25 16:04:03 volumio systemd[1]: Starting Hostname Service...
Jun 25 16:04:04 volumio ntpd[996]: Soliciting pool server 160.25.232.6
Jun 25 16:04:04 volumio dhcpcd[504]: wlan0: probing for an IPv4LL address
Jun 25 16:04:04 volumio dbus-daemon[389]: [system] Successfully activated service 'org.freedesktop.hostname1'
Jun 25 16:04:04 volumio systemd[1]: Started Hostname Service.
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::initPlayerControls
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: Express server listening on port 3000
Jun 25 16:04:04 volumio volumio[782]:  [Metrics]  WebUI:  5s 616.65ms 
Jun 25 16:04:04 volumio volumio[782]: info: Setting Device type: x86
Jun 25 16:04:04 volumio volumio[782]: info: CoreStateMachine::resetVolumioState
Jun 25 16:04:04 volumio volumio[782]: info: CoreStateMachine::getcurrentVolume
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::volumioRetrievevolume
Jun 25 16:04:04 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:04 volumio volumio[782]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jun 25 16:04:04 volumio volumio[782]: info: Completed loading Core Plugins
Jun 25 16:04:04 volumio volumio[782]: info: Preparing to generate the ALSA configuration file
Jun 25 16:04:04 volumio volumio[782]: info: Cannot read play queue from file
Jun 25 16:04:04 volumio mpd[1074]: client: [0] opened from local
Jun 25 16:04:04 volumio volumio[782]: info: MPD Permissions set
Jun 25 16:04:04 volumio volumio[782]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jun 25 16:04:04 volumio volumio[782]: wlan0     Interface doesn't support scanning : Operation not supported
Jun 25 16:04:04 volumio volumio[782]: info: Cannot use regular scanning, forcing with ap-force
Jun 25 16:04:04 volumio sudo[1196]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jun 25 16:04:04 volumio sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:05 volumio volumio-remote-updater[385]: [2023-06-25 16:04:05] [connect] Successful connection
Jun 25 16:04:06 volumio kernel: b43-phy0 ERROR: MAC suspend failed
Jun 25 16:04:07 volumio kernel: b43-phy0 ERROR: MAC suspend failed
Jun 25 16:04:07 volumio kernel: b43-phy0 ERROR: MAC suspend failed
Jun 25 16:04:07 volumio sudo[1196]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:07 volumio volumio[782]: info: MPD running with PID1074
Jun 25 16:04:07 volumio volumio[782]:  ,establishing connection
Jun 25 16:04:07 volumio mpd[1074]: client: [1] opened from local
Jun 25 16:04:07 volumio volumio[782]: Unable to parse:
Jun 25 16:04:07 volumio volumio[782]:  Simple mixer control 'IEC958',0
Jun 25 16:04:07 volumio volumio[782]:   Capabilities: pswitch pswitch-joined
Jun 25 16:04:07 volumio volumio[782]:   Playback channels: Mono
Jun 25 16:04:07 volumio volumio[782]:   Mono: Playback [on]
Jun 25 16:04:07 volumio volumio[782]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Jun 25 16:04:07 volumio volumio[782]: error: MPD error: The expression evaluated to a falsy value:
Jun 25 16:04:07 volumio volumio[782]:   assert.ok(self.idling)
Jun 25 16:04:07 volumio volumio[782]: error: The expression evaluated to a falsy value:
Jun 25 16:04:07 volumio volumio[782]:   assert.ok(self.idling)
Jun 25 16:04:07 volumio volumio-remote-updater[385]: [2023-06-25 16:04:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1687709045 101
Jun 25 16:04:07 volumio volumio[782]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: Unable to parse:
Jun 25 16:04:08 volumio volumio[782]:  Simple mixer control 'IEC958',0
Jun 25 16:04:08 volumio volumio[782]:   Capabilities: pswitch pswitch-joined
Jun 25 16:04:08 volumio volumio[782]:   Playback channels: Mono
Jun 25 16:04:08 volumio volumio[782]:   Mono: Playback [on]
Jun 25 16:04:08 volumio volumio[782]: info: VolumeController:: Volume=undefined Mute =false
Jun 25 16:04:08 volumio volumio[782]: info: CoreStateMachine::pushState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioPushState
Jun 25 16:04:08 volumio volumio[782]: info: CoreStateMachine::updateTrackBlock
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrackBlock
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioRetrievevolume
Jun 25 16:04:08 volumio volumio[782]: info: CoreStateMachine::setRepeat null single undefined
Jun 25 16:04:08 volumio volumio[782]: info: CoreStateMachine::pushState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioPushState
Jun 25 16:04:08 volumio volumio[782]: info: CoreStateMachine::setRandom null
Jun 25 16:04:08 volumio volumio[782]: info: CoreStateMachine::pushState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioPushState
Jun 25 16:04:08 volumio volumio[782]: error: updateQueue error: null
Jun 25 16:04:08 volumio volumio[782]: info: Asound.conf file written
Jun 25 16:04:08 volumio sudo[1253]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jun 25 16:04:08 volumio sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:08 volumio sudo[1253]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:08 volumio volumio[782]: No state is present for card HDMI
Jun 25 16:04:08 volumio volumio[782]: Found hardware: "HDA-Intel" "Intel Broadwell HDMI" "HDA:80862808,80860101,00100000" "0x8086" "0x160c"
Jun 25 16:04:08 volumio volumio[782]: Hardware is initialized using a generic method
Jun 25 16:04:08 volumio volumio[782]: No state is present for card HDMI
Jun 25 16:04:08 volumio volumio[782]: No state is present for card PCH
Jun 25 16:04:08 volumio volumio[782]: Found hardware: "HDA-Intel" "Realtek ALC662 rev3" "HDA:10ec0662,10ec0000,00100300" "0x8086" "0x7270"
Jun 25 16:04:08 volumio volumio[782]: Hardware is initialized using a generic method
Jun 25 16:04:08 volumio volumio[782]: No state is present for card PCH
Jun 25 16:04:08 volumio volumio[782]: info: Output device has changed, restarting MPD
Jun 25 16:04:08 volumio sudo[1258]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 25 16:04:08 volumio sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:08 volumio volumio[782]: info: Output device has changed, restarting Shairport Sync
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:08 volumio sudo[1258]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:08 volumio sudo[1260]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 25 16:04:08 volumio sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:08 volumio systemd[1]: Stopping Music Player Daemon...
Jun 25 16:04:08 volumio volumio[782]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 25 16:04:08 volumio volumio[782]: info: ___________ START PLUGINS ___________
Jun 25 16:04:08 volumio systemd[1]: mpd.service: Succeeded.
Jun 25 16:04:08 volumio systemd[1]: Stopped Music Player Daemon.
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 25 16:04:08 volumio volumio[782]: info: [1687709048112] CoreMusicLibrary::Adding element Media Servers
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 25 16:04:08 volumio systemd[1]: Starting Music Player Daemon...
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 25 16:04:08 volumio volumio[782]: info: [1687709048144] CoreMusicLibrary::Adding element Last_100
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 25 16:04:08 volumio volumio[782]: info: [1687709048145] CoreMusicLibrary::Adding element Webradio
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 25 16:04:08 volumio volumio[782]: info: Volumio Calling Home
Jun 25 16:04:08 volumio volumio[782]: info: Completed starting Core Plugins
Jun 25 16:04:08 volumio volumio[782]: info: -------------------------------------------
Jun 25 16:04:08 volumio volumio[782]: info: -----    MyVolumio plugins startup     ----
Jun 25 16:04:08 volumio volumio[782]: info: -------------------------------------------
Jun 25 16:04:08 volumio volumio[782]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 25 16:04:08 volumio volumio[782]: info: MPD Permissions set
Jun 25 16:04:08 volumio volumio[782]: Unable to parse:
Jun 25 16:04:08 volumio volumio[782]:  Simple mixer control 'IEC958',0
Jun 25 16:04:08 volumio volumio[782]:   Capabilities: pswitch pswitch-joined
Jun 25 16:04:08 volumio volumio[782]:   Playback channels: Mono
Jun 25 16:04:08 volumio volumio[782]:   Mono: Playback [on]
Jun 25 16:04:08 volumio volumio[782]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Jun 25 16:04:08 volumio volumio[782]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:08 volumio volumio[782]: Unable to parse:
Jun 25 16:04:08 volumio volumio[782]:  Simple mixer control 'IEC958',0
Jun 25 16:04:08 volumio volumio[782]:   Capabilities: pswitch pswitch-joined
Jun 25 16:04:08 volumio volumio[782]:   Playback channels: Mono
Jun 25 16:04:08 volumio volumio[782]:   Mono: Playback [on]
Jun 25 16:04:08 volumio volumio[782]: info: VolumeController:: Volume=undefined Mute =false
Jun 25 16:04:08 volumio volumio[782]: info: CoreStateMachine::pushState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioPushState
Jun 25 16:04:08 volumio volumio[782]: info: Starting Shairport Sync
Jun 25 16:04:08 volumio volumio[782]: info: Starting Shairport Sync
Jun 25 16:04:08 volumio volumio[782]: info: Starting Shairport Sync
Jun 25 16:04:08 volumio sudo[1288]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 25 16:04:08 volumio sudo[1288]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:08 volumio sudo[1286]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 25 16:04:08 volumio sudo[1286]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 25 16:04:08 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 25 16:04:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 25 16:04:08 volumio sudo[1291]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 25 16:04:08 volumio sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 25 16:04:08 volumio sudo[1288]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:08 volumio volumio[782]: info: Shairport-Sync Started
Jun 25 16:04:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 25 16:04:08 volumio volumio[782]: Error adding Membership: Error: addMembership EINVAL
Jun 25 16:04:08 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 25 16:04:08 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 25 16:04:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 25 16:04:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 25 16:04:08 volumio sudo[1286]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:08 volumio sudo[1291]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:08 volumio volumio[782]: info: Shairport-Sync Started
Jun 25 16:04:08 volumio volumio[782]: info: Shairport-Sync Started
Jun 25 16:04:08 volumio volumio[782]: info: Discovery: adding f3731b2b-ec52-45dd-b1e3-9d8cc6a02b8e
Jun 25 16:04:08 volumio volumio[782]: info: Discovery: Found device Volumio
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioGetState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioGetState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio mpd[1276]: Jun 25 16:04 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 25 16:04:08 volumio mpd[1276]: Jun 25 16:04 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jun 25 16:04:08 volumio mpd[1276]: Jun 25 16:04 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jun 25 16:04:08 volumio kernel: b43-phy0 ERROR: MAC suspend failed
Jun 25 16:04:08 volumio systemd[1]: Started Music Player Daemon.
Jun 25 16:04:08 volumio sudo[1260]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:08 volumio volumio[782]: error: updateQueue error: null
Jun 25 16:04:08 volumio volumio[782]: info: Discovery: this is already registered,  f3731b2b-ec52-45dd-b1e3-9d8cc6a02b8e
Jun 25 16:04:08 volumio volumio[782]: info: Discovery: Found device Volumio
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioGetState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio volumio[782]: info: Volumio called home
Jun 25 16:04:08 volumio volumio[782]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 3
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Jun 25 16:04:08 volumio volumio[782]: info: Received Get System Info
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 25 16:04:08 volumio volumio[782]: info: Discovery: Getting this device information
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::volumioGetState
Jun 25 16:04:08 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 25 16:04:08 volumio volumio-remote-updater[385]: No test mode
Jun 25 16:04:08 volumio volumio-remote-updater[385]: No alpha test mode
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 25 16:04:08 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 25 16:04:09 volumio dhcpcd[504]: wlan0: using IPv4LL address 169.254.154.254
Jun 25 16:04:09 volumio dhcpcd[504]: wlan0: adding route to 169.254.0.0/16
Jun 25 16:04:09 volumio avahi-daemon[388]: Registering new address record for 169.254.154.254 on wlan0.IPv4.
Jun 25 16:04:09 volumio volumio[782]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES


Fix for lost MPD database after reboot
 
Fix for TIDAL authentication refresh
 
Fix TIDAL low quality (AAC) playback
 
Fix for DLNA Server discovery
Fix for Plugins installation


NEW ADDITIONS


Update Bluez to v5.83
 
Update TIDAL SDK
 
Add Bluetooth A2DP playback
 ","title":"Update v3.886","updateavailable":true}
Jun 25 16:04:09 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jun 25 16:04:10 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 25 16:04:10 volumio ntpd[996]: Listen normally on 5 wlan0 169.254.154.254:123
Jun 25 16:04:10 volumio ntpd[996]: new interface(s) found: waking up resolver
Jun 25 16:04:12 volumio sudo[1492]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 25 16:04:12 volumio sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:12 volumio sudo[1492]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:12 volumio sudo[1494]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 25 16:04:12 volumio sudo[1494]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:12 volumio sudo[1494]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:12 volumio sudo[1498]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jun 25 16:04:12 volumio sudo[1498]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:12 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jun 25 16:04:12 volumio sudo[1498]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:12 volumio volumio[782]: info: Upmpdcli Daemon Started
Jun 25 16:04:12 volumio volumio[1500]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jun 25 16:04:12 volumio volumio[1500]: ................................................................................................................++++
Jun 25 16:04:12 volumio volumio[1500]: ..........................................++++
Jun 25 16:04:12 volumio volumio[1500]: e is 65537 (0x010001)
Jun 25 16:04:12 volumio volumio[1500]: writing RSA key
Jun 25 16:04:12 volumio volumio[782]: error: Failed LSINFO: Error:  [50@0] {lsinfo} No such directory
Jun 25 16:04:14 volumio kernel: usb 3-4: USB disconnect, device number 2
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 9788724 op 0x1:(WRITE) flags 0x800 phys_seg 62 prio class 0
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 3498104 op 0x1:(WRITE) flags 0x800 phys_seg 2 prio class 0
Jun 25 16:04:14 volumio kernel: Aborting journal on device sda2-8.
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 20551710 op 0x1:(WRITE) flags 0x800 phys_seg 1 prio class 0
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1581236 starting block 10275856)
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6564879
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 3497984 op 0x1:(WRITE) flags 0x800 phys_seg 1 prio class 0
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda2, logical block 393216, lost sync page write
Jun 25 16:04:14 volumio kernel: JBD2: Error -5 detected when updating journal superblock for sda2-8.
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 20545544 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 0
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580808 starting block 10272773)
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6561796
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 20555778 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 0
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580920 starting block 10277890)
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6566913
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 20550666 op 0x1:(WRITE) flags 0x800 phys_seg 1 prio class 0
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1581236 starting block 10275335)
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6564357
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6564358
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 20556808 op 0x1:(WRITE) flags 0x800 phys_seg 2 prio class 0
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda3): Delayed block allocation failed for inode 1580857 at logical offset 0 with max blocks 1 with error 5
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda3): This should not happen!! Data will be lost
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 20549656 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 0
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580874 starting block 10274837)
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6563852
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6563853
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6563854
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6563855
Jun 25 16:04:14 volumio kernel: Buffer I/O error on device sda3, logical block 6563856
Jun 25 16:04:14 volumio kernel: blk_update_request: I/O error, dev sda, sector 7439830 op 0x1:(WRITE) flags 0x0 phys_seg 1 prio class 0
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580876 starting block 3719935)
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580876 starting block 3720961)
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580930 starting block 10274838)
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580975 starting block 10272822)
Jun 25 16:04:14 volumio kernel: EXT4-fs warning (device sda3): ext4_end_bio:351: I/O error 10 writing to inode 1580977 starting block 10272835)
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 3, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 4, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 5, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 6, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 7, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 8, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 9, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 10, lost async page write
Jun 25 16:04:14 volumio kernel: Buffer I/O error on dev sda3, logical block 264, lost async page write
Jun 25 16:04:14 volumio kernel: JBD2: Detected IO errors while flushing file data on sda3-8
Jun 25 16:04:14 volumio kernel: Aborting journal on device sda3-8.
Jun 25 16:04:14 volumio kernel: JBD2: Error -5 detected when updating journal superblock for sda3-8.
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda3): I/O error while writing superblock
Jun 25 16:04:14 volumio kernel: EXT4-fs error (device sda3): ext4_journal_check_start:83: Detected aborted journal
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda3): Remounting filesystem read-only
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda3): ext4_writepages: jbd2_start: 9223372036854775807 pages, ino 1580857; err -30
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 3.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 4.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 5.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 7.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 8.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 9.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 10.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 264.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553601.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553633.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553635.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553636.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553638.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553639.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553640.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553641.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553643.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553644.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553645.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553646.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553647.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553648.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553651.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553652.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553653.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553657.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553660.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553663.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553664.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553665.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553669.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553674.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553679.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553680.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553681.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553682.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6553683.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557585.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557586.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557588.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557605.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557607.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557608.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557613.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557616.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557621.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557625.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557632.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557636.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557637.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557644.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557647.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557669.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557673.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557680.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557712.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557715.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557716.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557717.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557718.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557720.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557724.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557725.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557726.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557730.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557731.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557732.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557733.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557734.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557735.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557737.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557738.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557741.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557742.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557744.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557768.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557769.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557770.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557771.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557772.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557773.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557776.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557784.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557788.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557790.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557791.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557792.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557794.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557795.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557796.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557797.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557798.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557799.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557800.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557801.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557802.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557804.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557805.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 6557806.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 9961505.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 9965459.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 0.
Jun 25 16:04:14 volumio kernel: JBD2: Error while async write back metadata bh 466.
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda2): previous I/O error to superblock detected
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda2): I/O error while writing superblock
Jun 25 16:04:14 volumio kernel: EXT4-fs error (device sda2): ext4_journal_check_start:83: Detected aborted journal
Jun 25 16:04:14 volumio kernel: EXT4-fs (sda2): Remounting filesystem read-only
Jun 25 16:04:14 volumio kernel: ------------[ cut here ]------------
Jun 25 16:04:14 volumio kernel: bdi-8:0 not registered
Jun 25 16:04:14 volumio kernel: WARNING: CPU: 2 PID: 187 at fs/fs-writeback.c:2312 __mark_inode_dirty+0x25d/0x300
Jun 25 16:04:14 volumio kernel: Modules linked in: bnep bluetooth jitterentropy_rng hmac drbg ansi_cprng ecdh_generic ecc b43 cordic mac80211 snd_hda_codec_hdmi i915 intel_rapl_common x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel kvm sha256_generic cfg80211 nft_counter nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nft_compat nf_tables libcrc32c nfnetlink 8021q garp stp mrp llc irqbypass crc32_pclmul ssb rng_core libarc4 snd_hda_codec_realtek at24 snd_hda_codec_generic cec ledtrig_audio rc_core sg drm_kms_helper aesni_intel snd_hda_intel drm snd_intel_dspcfg uas snd_hda_codec snd_hda_core bcma snd_hwdep snd_pcm glue_helper libaes crypto_simd cryptd igb mei_me mei efi_pstore i2c_i801 snd_seq fb_sys_fops snd_seq_device snd_timer syscopyarea sysfillrect sysimgblt i2c_smbus i2c_algo_bit snd lpc_ich soundcore acpi_pad video backlight sunrpc efivarfs ip_tables autofs4 vfat fat ext4 crc32c_generic crc32c_intel crc16 mbcache jbd2 sata_via sata_sis pata_amd pata_via pata_sch
Jun 25 16:04:14 volumio kernel:  pata_atiixp ahci libahci usb_storage loop hid_generic hid_cherry usbhid hid sdhci_acpi sdhci_pci cqhci sdhci mmc_block nvme nvme_core fuse nls_utf8 nls_cp437 squashfs overlay
Jun 25 16:04:14 volumio kernel: CPU: 2 PID: 187 Comm: loop0 Not tainted 5.10.176-volumio #1
Jun 25 16:04:14 volumio kernel: Hardware name: To be filled by O.E.M. To be filled by O.E.M./CRESCENTBAY, BIOS 5.6.5 11/22/2017
Jun 25 16:04:14 volumio kernel: RIP: 0010:__mark_inode_dirty+0x25d/0x300
Jun 25 16:04:14 volumio kernel: Code: ff ff 48 8b 38 49 89 c4 f6 47 44 01 74 1e 48 8b 40 08 a8 01 75 16 e8 f2 d8 f4 ff 48 c7 c7 ab 45 ff 81 48 89 c6 e8 4c 1f 5f 00 <0f> 0b 48 8b 05 da c7 f4 00 48 89 83 c8 00 00 00 45 85 ff 74 0e 48
Jun 25 16:04:14 volumio kernel: RSP: 0018:ffffc90000633b98 EFLAGS: 00010282
Jun 25 16:04:14 volumio kernel: RAX: 0000000000000000 RBX: ffff88800aeb81c0 RCX: 0000000000000027
Jun 25 16:04:14 volumio kernel: RDX: 0000000000000027 RSI: ffff88810051ba00 RDI: ffff88810051ba08
Jun 25 16:04:14 volumio kernel: RBP: ffffc90000633bc0 R08: 0000000000000000 R09: c0000000ffffefff
Jun 25 16:04:14 volumio kernel: R10: 0000000000000001 R11: ffffc90000633958 R12: ffff8880347f3c60
Jun 25 16:04:14 volumio kernel: R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
Jun 25 16:04:14 volumio kernel: FS:  0000000000000000(0000) GS:ffff888100500000(0000) knlGS:0000000000000000
Jun 25 16:04:14 volumio kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jun 25 16:04:14 volumio kernel: CR2: 00007f65a80b1628 CR3: 0000000016eb6001 CR4: 00000000003706e0
Jun 25 16:04:14 volumio kernel: DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Jun 25 16:04:14 volumio kernel: DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Jun 25 16:04:14 volumio kernel: Call Trace:
Jun 25 16:04:14 volumio kernel:  generic_update_time+0xba/0xd0
Jun 25 16:04:14 volumio kernel:  inode_update_time+0x29/0x30
Jun 25 16:04:14 volumio kernel:  touch_atime+0xb7/0x110
Jun 25 16:04:14 volumio kernel:  generic_file_buffered_read+0x68c/0x820
Jun 25 16:04:14 volumio kernel:  generic_file_read_iter+0xc8/0x130
Jun 25 16:04:14 volumio kernel:  ext4_file_read_iter+0x57/0x110 [ext4]
Jun 25 16:04:14 volumio kernel:  do_iter_readv_writev+0x196/0x1c0
Jun 25 16:04:14 volumio kernel:  do_iter_read+0xd3/0x1b0
Jun 25 16:04:14 volumio kernel:  vfs_iter_read+0x19/0x30
Jun 25 16:04:14 volumio kernel:  loop_queue_work+0x318/0xa27 [loop]
Jun 25 16:04:14 volumio kernel:  ? __switch_to+0x12e/0x420
Jun 25 16:04:14 volumio kernel:  kthread_worker_fn+0x9c/0x1b0
Jun 25 16:04:14 volumio kernel:  ? loop_info64_to_compat+0x210/0x210 [loop]
Jun 25 16:04:14 volumio kernel:  loop_kthread_worker_fn+0x1e/0x30 [loop]
Jun 25 16:04:14 volumio kernel:  kthread+0x12c/0x150
Jun 25 16:04:14 volumio kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jun 25 16:04:14 volumio kernel:  ret_from_fork+0x22/0x30
Jun 25 16:04:14 volumio kernel: ---[ end trace 5085f4ddf1f9fafb ]---
Jun 25 16:04:14 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #2402817: comm node: reading directory lblock 0
Jun 25 16:04:14 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #2402817: comm node: reading directory lblock 0
Jun 25 16:04:14 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #2402817: comm node: reading directory lblock 0
Jun 25 16:04:14 volumio systemd[1]: Stopped target Local File Systems.
Jun 25 16:04:14 volumio volumio[782]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:14.0/usb3/3-4/3-4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda3","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/12a8ee05-e7f9-406b-97f4-cd5a1b97c8d6 /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4-0:0-part3 /dev/disk/by-path/pci-0000:00:14.0-usb-0:4:1.0-scsi-0:0:0:0-part3 /dev/disk/by-label/volumio_data /dev/disk/by-partuuid/a482b6ce-66bb-4d4b-a7f8-79cf310d47bb /dev/disk/by-partlabel/primary","DEVNAME":"/dev/sda3","DEVPATH":"/devices/pci0000:00/0000:00:14.0/usb3/3-4/3-4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda3","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"12a8ee05-e7f9-406b-97f4-cd5a1b97c8d6","ID_FS_UUID_ENC":"12a8ee05-e7f9-406b-97f4-cd5a1b97c8d6","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5591","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"primary","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"7421952","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"52703049","ID_PART_ENTRY_TYPE":"0fc63daf-8483-4772-8e79-3d69d8477de4","ID_PART_ENTRY_UUID":"a482b6ce-66bb-4d4b-a7f8-79cf310d47bb","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"d6a04bbd-271b-4a9b-8ce3-d0f7543655c1","ID_PATH":"pci-0000:00:14.0-usb-0:4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_14_0-usb-0_4_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4-0:0","ID_SERIAL_SHORT":"01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"3","PARTN":"3","PARTNAME":"primary","SEQNUM":"2296","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"16593013"}
Jun 25 16:04:14 volumio volumio[782]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:14.0/usb3/3-4/3-4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/ab110853-1246-489b-a3e9-a511c39e64bf /dev/disk/by-uuid/995b3bef-0123-488a-8237-3568c5f00abb /dev/disk/by-path/pci-0000:00:14.0-usb-0:4:1.0-scsi-0:0:0:0-part2 /dev/disk/by-partlabel/primary /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4-0:0-part2 /dev/disk/by-label/volumio","DEVNAME":"/dev/sda2","DEVPATH":"/devices/pci0000:00/0000:00:14.0/usb3/3-4/3-4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"995b3bef-0123-488a-8237-3568c5f00abb","ID_FS_UUID_ENC":"995b3bef-0123-488a-8237-3568c5f00abb","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5591","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"primary","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"352256","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"7069696","ID_PART_ENTRY_TYPE":"0fc63daf-8483-4772-8e79-3d69d8477de4","ID_PART_ENTRY_UUID":"ab110853-1246-489b-a3e9-a511c39e64bf","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"d6a04bbd-271b-4a9b-8ce3-d0f7543655c1","ID_PATH":"pci-0000:00:14.0-usb-0:4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_14_0-usb-0_4_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4-0:0","ID_SERIAL_SHORT":"01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"primary","SEQNUM":"2297","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"16577456"}
Jun 25 16:04:14 volumio systemd[1]: Unmounting /boot...
Jun 25 16:04:14 volumio volumio[782]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:14.0/usb3/3-4/3-4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/boot /dev/disk/by-id/usb-USB_SanDisk_3.2Gen1_01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4-0:0-part1 /dev/disk/by-partuuid/ff509d8e-3d4a-4c47-bfab-2d86dff6f1d5 /dev/disk/by-partlabel/primary /dev/disk/by-uuid/5A07-DE33 /dev/disk/by-path/pci-0000:00:14.0-usb-0:4:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/pci0000:00/0000:00:14.0/usb3/3-4/3-4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"5A07-DE33","ID_FS_UUID_ENC":"5A07-DE33","ID_FS_VERSION":"FAT16","ID_INSTANCE":"0:0","ID_MODEL":"SanDisk_3.2Gen1","ID_MODEL_ENC":"\\x20SanDisk\\x203.2Gen1","ID_MODEL_ID":"5591","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x4","ID_PART_ENTRY_NAME":"primary","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"350208","ID_PART_ENTRY_TYPE":"c12a7328-f81f-11d2-ba4b-00a0c93ec93b","ID_PART_ENTRY_UUID":"ff509d8e-3d4a-4c47-bfab-2d86dff6f1d5","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"d6a04bbd-271b-4a9b-8ce3-d0f7543655c1","ID_PATH":"pci-0000:00:14.0-usb-0:4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_14_0-usb-0_4_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"USB_SanDisk_3.2Gen1_01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4-0:0","ID_SERIAL_SHORT":"01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"\\x20USB\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"primary","SEQNUM":"2298","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"16562442"}
Jun 25 16:04:14 volumio systemd[1]: boot.mount: Succeeded.
Jun 25 16:04:14 volumio systemd[1]: Unmounted /boot.
Jun 25 16:04:14 volumio systemd[1]: systemd-fsck@dev-disk-by\x2duuid-5A07\x2dDE33.service: Succeeded.
Jun 25 16:04:14 volumio systemd[1]: Stopped File System Check on /dev/disk/by-uuid/5A07-DE33.
Jun 25 16:04:14 volumio kernel: FAT-fs (sda1): unable to read boot sector to mark fs as dirty
Jun 25 16:04:14 volumio kernel: ------------[ cut here ]------------
Jun 25 16:04:14 volumio kernel: bdi-(unknown) not registered
Jun 25 16:04:14 volumio kernel: WARNING: CPU: 1 PID: 1022 at fs/fs-writeback.c:2312 __mark_inode_dirty+0x25d/0x300
Jun 25 16:04:14 volumio kernel: Modules linked in: bnep bluetooth jitterentropy_rng hmac drbg ansi_cprng ecdh_generic ecc b43 cordic mac80211 snd_hda_codec_hdmi i915 intel_rapl_common x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel kvm sha256_generic cfg80211 nft_counter nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nft_compat nf_tables libcrc32c nfnetlink 8021q garp stp mrp llc irqbypass crc32_pclmul ssb rng_core libarc4 snd_hda_codec_realtek at24 snd_hda_codec_generic cec ledtrig_audio rc_core sg drm_kms_helper aesni_intel snd_hda_intel drm snd_intel_dspcfg uas snd_hda_codec snd_hda_core bcma snd_hwdep snd_pcm glue_helper libaes crypto_simd cryptd igb mei_me mei efi_pstore i2c_i801 snd_seq fb_sys_fops snd_seq_device snd_timer syscopyarea sysfillrect sysimgblt i2c_smbus i2c_algo_bit snd lpc_ich soundcore acpi_pad video backlight sunrpc efivarfs ip_tables autofs4 vfat fat ext4 crc32c_generic crc32c_intel crc16 mbcache jbd2 sata_via sata_sis pata_amd pata_via pata_sch
Jun 25 16:04:14 volumio kernel:  pata_atiixp ahci libahci usb_storage loop hid_generic hid_cherry usbhid hid sdhci_acpi sdhci_pci cqhci sdhci mmc_block nvme nvme_core fuse nls_utf8 nls_cp437 squashfs overlay
Jun 25 16:04:14 volumio kernel: CPU: 1 PID: 1022 Comm: chromium Tainted: G        W         5.10.176-volumio #1
Jun 25 16:04:14 volumio kernel: Hardware name: To be filled by O.E.M. To be filled by O.E.M./CRESCENTBAY, BIOS 5.6.5 11/22/2017
Jun 25 16:04:14 volumio kernel: RIP: 0010:__mark_inode_dirty+0x25d/0x300
Jun 25 16:04:14 volumio kernel: Code: ff ff 48 8b 38 49 89 c4 f6 47 44 01 74 1e 48 8b 40 08 a8 01 75 16 e8 f2 d8 f4 ff 48 c7 c7 ab 45 ff 81 48 89 c6 e8 4c 1f 5f 00 <0f> 0b 48 8b 05 da c7 f4 00 48 89 83 c8 00 00 00 45 85 ff 74 0e 48
Jun 25 16:04:14 volumio kernel: RSP: 0000:ffffc9000067fcb0 EFLAGS: 00010282
Jun 25 16:04:14 volumio kernel: RAX: 0000000000000000 RBX: ffff8880197e4140 RCX: 0000000000000027
Jun 25 16:04:14 volumio kernel: RDX: 0000000000000027 RSI: ffff88810049ba00 RDI: ffff88810049ba08
Jun 25 16:04:14 volumio kernel: RBP: ffffc9000067fcd8 R08: 0000000000000000 R09: c0000000ffffefff
Jun 25 16:04:14 volumio kernel: R10: 0000000000000001 R11: ffffc9000067fa70 R12: ffff8880347f3c60
Jun 25 16:04:14 volumio kernel: R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
Jun 25 16:04:14 volumio kernel: FS:  00007f65d314ef80(0000) GS:ffff888100480000(0000) knlGS:0000000000000000
Jun 25 16:04:14 volumio kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jun 25 16:04:14 volumio kernel: CR2: 00007f65d209d1ec CR3: 0000000016eb6004 CR4: 00000000003706e0
Jun 25 16:04:14 volumio kernel: DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Jun 25 16:04:14 volumio kernel: DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Jun 25 16:04:14 volumio kernel: Call Trace:
Jun 25 16:04:14 volumio kernel:  generic_update_time+0xba/0xd0
Jun 25 16:04:14 volumio kernel:  inode_update_time+0x29/0x30
Jun 25 16:04:14 volumio kernel:  file_update_time+0xcc/0x120
Jun 25 16:04:14 volumio kernel:  ext4_page_mkwrite+0x88/0x5f0 [ext4]
Jun 25 16:04:14 volumio kernel:  ? touch_atime+0xbf/0x110
Jun 25 16:04:14 volumio kernel:  do_page_mkwrite+0x57/0xc0
Jun 25 16:04:14 volumio kernel:  do_wp_page+0x25a/0x380
Jun 25 16:04:14 volumio kernel:  handle_mm_fault+0xe4d/0x14d0
Jun 25 16:04:14 volumio kernel:  exc_page_fault+0x25e/0x4c0
Jun 25 16:04:14 volumio kernel:  ? exit_to_user_mode_prepare+0x32/0x150
Jun 25 16:04:14 volumio kernel:  ? asm_exc_page_fault+0x8/0x30
Jun 25 16:04:14 volumio kernel:  asm_exc_page_fault+0x1e/0x30
Jun 25 16:04:14 volumio kernel: RIP: 0033:0x5626f5ee6da3
Jun 25 16:04:14 volumio kernel: Code: 85 d2 78 13 66 45 01 cb 73 13 eb 4d 66 2e 0f 1f 84 00 00 00 00 00 90 66 45 29 cb 72 3f 41 c1 e3 10 45 09 d3 41 83 fb ff 74 2c  45 0f b1 58 14 75 b5 4c 8b 47 08 48 63 c6 48 63 ca 48 0f af c8
Jun 25 16:04:14 volumio kernel: RSP: 002b:00007ffc5d5c7d28 EFLAGS: 00010213
Jun 25 16:04:14 volumio kernel: RAX: 0000000000010000 RBX: 0000000000000000 RCX: 0000000000000000
Jun 25 16:04:14 volumio kernel: RDX: 0000000000000001 RSI: 0000000000000000 RDI: 00005626fd0b1760
Jun 25 16:04:14 volumio kernel: RBP: 00007ffc5d5c7d60 R08: 00007f65d209d1d8 R09: 0000000000000001
Jun 25 16:04:14 volumio kernel: R10: 0000000000000000 R11: 0000000000020000 R12: 0000000000000000
Jun 25 16:04:14 volumio kernel: R13: 00005626fd0b1760 R14: 0000000000000001 R15: 0000000000000000
Jun 25 16:04:14 volumio kernel: ---[ end trace 5085f4ddf1f9fafc ]---
Jun 25 16:04:14 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:14 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:15 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:15 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:15 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:15 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:15 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:15 volumio kernel: usb 2-8: new high-speed USB device number 4 using xhci_hcd
Jun 25 16:04:15 volumio kernel: usb 2-8: New USB device found, idVendor=0781, idProduct=5591, bcdDevice= 1.00
Jun 25 16:04:15 volumio kernel: usb 2-8: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jun 25 16:04:15 volumio kernel: usb 2-8: Product:  SanDisk 3.2Gen1
Jun 25 16:04:15 volumio kernel: usb 2-8: Manufacturer:  USB
Jun 25 16:04:15 volumio kernel: usb 2-8: SerialNumber: 01014caae736bfae6e7212022072f0649a4baf2cd77a31100fa42f5580042e3b811e000000000000000000009b58edd3ff105a009155810726b145d4
Jun 25 16:04:15 volumio kernel: usb-storage 2-8:1.0: USB Mass Storage device detected
Jun 25 16:04:15 volumio kernel: scsi host1: usb-storage 2-8:1.0
Jun 25 16:04:16 volumio kernel: scsi 1:0:0:0: Direct-Access      USB      SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6
Jun 25 16:04:16 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0
Jun 25 16:04:16 volumio kernel: sd 1:0:0:0: [sdb] 60125184 512-byte logical blocks: (30.8 GB/28.7 GiB)
Jun 25 16:04:16 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off
Jun 25 16:04:16 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00
Jun 25 16:04:16 volumio kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Jun 25 16:04:16 volumio kernel:  sdb: sdb1 sdb2 sdb3
Jun 25 16:04:16 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk
Jun 25 16:04:17 volumio kernel: ------------[ cut here ]------------
Jun 25 16:04:17 volumio kernel: bdi-(unknown) not registered
Jun 25 16:04:17 volumio kernel: WARNING: CPU: 1 PID: 1124 at fs/fs-writeback.c:2312 __mark_inode_dirty+0x25d/0x300
Jun 25 16:04:17 volumio kernel: Modules linked in: bnep bluetooth jitterentropy_rng hmac drbg ansi_cprng ecdh_generic ecc b43 cordic mac80211 snd_hda_codec_hdmi i915 intel_rapl_common x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel kvm sha256_generic cfg80211 nft_counter nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nft_compat nf_tables libcrc32c nfnetlink 8021q garp stp mrp llc irqbypass crc32_pclmul ssb rng_core libarc4 snd_hda_codec_realtek at24 snd_hda_codec_generic cec ledtrig_audio rc_core sg drm_kms_helper aesni_intel snd_hda_intel drm snd_intel_dspcfg uas snd_hda_codec snd_hda_core bcma snd_hwdep snd_pcm glue_helper libaes crypto_simd cryptd igb mei_me mei efi_pstore i2c_i801 snd_seq fb_sys_fops snd_seq_device snd_timer syscopyarea sysfillrect sysimgblt i2c_smbus i2c_algo_bit snd lpc_ich soundcore acpi_pad video backlight sunrpc efivarfs ip_tables autofs4 vfat fat ext4 crc32c_generic crc32c_intel crc16 mbcache jbd2 sata_via sata_sis pata_amd pata_via pata_sch
Jun 25 16:04:17 volumio kernel:  pata_atiixp ahci libahci usb_storage loop hid_generic hid_cherry usbhid hid sdhci_acpi sdhci_pci cqhci sdhci mmc_block nvme nvme_core fuse nls_utf8 nls_cp437 squashfs overlay
Jun 25 16:04:17 volumio kernel: CPU: 1 PID: 1124 Comm: ThreadPoolForeg Tainted: G        W         5.10.176-volumio #1
Jun 25 16:04:17 volumio kernel: Hardware name: To be filled by O.E.M. To be filled by O.E.M./CRESCENTBAY, BIOS 5.6.5 11/22/2017
Jun 25 16:04:17 volumio kernel: RIP: 0010:__mark_inode_dirty+0x25d/0x300
Jun 25 16:04:17 volumio kernel: Code: ff ff 48 8b 38 49 89 c4 f6 47 44 01 74 1e 48 8b 40 08 a8 01 75 16 e8 f2 d8 f4 ff 48 c7 c7 ab 45 ff 81 48 89 c6 e8 4c 1f 5f 00 <0f> 0b 48 8b 05 da c7 f4 00 48 89 83 c8 00 00 00 45 85 ff 74 0e 48
Jun 25 16:04:17 volumio kernel: RSP: 0018:ffffc90000937bb0 EFLAGS: 00010282
Jun 25 16:04:17 volumio kernel: RAX: 0000000000000000 RBX: ffff88802fa22a50 RCX: 0000000000000027
Jun 25 16:04:17 volumio kernel: RDX: 0000000000000027 RSI: ffff88810049ba00 RDI: ffff88810049ba08
Jun 25 16:04:17 volumio kernel: RBP: ffffc90000937bd8 R08: 0000000000000000 R09: c0000000ffffefff
Jun 25 16:04:17 volumio kernel: R10: 0000000000000001 R11: ffffc90000937970 R12: ffff8880347f3c60
Jun 25 16:04:17 volumio kernel: R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
Jun 25 16:04:17 volumio kernel: FS:  00007f65a6ffd700(0000) GS:ffff888100480000(0000) knlGS:0000000000000000
Jun 25 16:04:17 volumio kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jun 25 16:04:17 volumio kernel: CR2: 00007fbcf429e200 CR3: 0000000016eb6001 CR4: 00000000003706e0
Jun 25 16:04:17 volumio kernel: DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Jun 25 16:04:17 volumio kernel: DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Jun 25 16:04:17 volumio kernel: Call Trace:
Jun 25 16:04:17 volumio kernel:  generic_update_time+0xba/0xd0
Jun 25 16:04:17 volumio kernel:  inode_update_time+0x29/0x30
Jun 25 16:04:17 volumio kernel:  file_update_time+0xcc/0x120
Jun 25 16:04:17 volumio kernel:  file_modified+0x24/0x30
Jun 25 16:04:17 volumio kernel:  ext4_buffered_write_iter+0x5f/0x170 [ext4]
Jun 25 16:04:17 volumio kernel:  ext4_file_write_iter+0x61/0x8a0 [ext4]
Jun 25 16:04:17 volumio kernel:  ? hrtimer_cancel+0x15/0x30
Jun 25 16:04:17 volumio kernel:  ? futex_wait+0x20b/0x250
Jun 25 16:04:17 volumio kernel:  do_iter_readv_writev+0x15b/0x1c0
Jun 25 16:04:17 volumio kernel:  do_iter_write+0x8e/0x1c0
Jun 25 16:04:17 volumio kernel:  vfs_iter_write+0x19/0x30
Jun 25 16:04:17 volumio kernel:  ovl_write_iter+0x2bc/0x430 [overlay]
Jun 25 16:04:17 volumio kernel:  new_sync_write+0x117/0x1b0
Jun 25 16:04:17 volumio kernel:  vfs_write+0x1cd/0x280
Jun 25 16:04:17 volumio kernel:  ksys_write+0x61/0xe0
Jun 25 16:04:17 volumio kernel:  __x64_sys_write+0x1a/0x20
Jun 25 16:04:17 volumio kernel:  do_syscall_64+0x37/0x50
Jun 25 16:04:17 volumio kernel:  entry_SYSCALL_64_after_hwframe+0x61/0xc6
Jun 25 16:04:17 volumio kernel: RIP: 0033:0x7f65df7734a7
Jun 25 16:04:17 volumio kernel: Code: 44 00 00 41 54 49 89 d4 55 48 89 f5 53 89 fb 48 83 ec 10 e8 fb fc ff ff 4c 89 e2 48 89 ee 89 df 41 89 c0 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 35 44 89 c7 48 89 44 24 08 e8 34 fd ff ff 48
Jun 25 16:04:17 volumio kernel: RSP: 002b:00007f65a6ffbea0 EFLAGS: 00000293 ORIG_RAX: 0000000000000001
Jun 25 16:04:17 volumio kernel: RAX: ffffffffffffffda RBX: 000000000000010c RCX: 00007f65df7734a7
Jun 25 16:04:17 volumio kernel: RDX: 0000000000000002 RSI: 00007f65a6ffbf9e RDI: 000000000000010c
Jun 25 16:04:17 volumio kernel: RBP: 00007f65a6ffbf9e R08: 0000000000000000 R09: 0000000000000000
Jun 25 16:04:17 volumio kernel: R10: 00007ffc5d5fa090 R11: 0000000000000293 R12: 0000000000000002
Jun 25 16:04:17 volumio kernel: R13: 00007f65a6ffbf9e R14: 0000000000000002 R15: 0000000000000000
Jun 25 16:04:17 volumio kernel: ---[ end trace 5085f4ddf1f9fafd ]---
Jun 25 16:04:17 volumio volumio[782]: info: Ignoring mount for partition: volumio_data
Jun 25 16:04:17 volumio volumio[782]: info: Ignoring mount for partition: volumio
Jun 25 16:04:17 volumio volumio[782]: info: Ignoring mount for partition: boot
Jun 25 16:04:17 volumio sudo[1541]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 25 16:04:17 volumio sudo[1541]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:17 volumio sudo[1541]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:17 volumio sudo[1543]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 25 16:04:17 volumio sudo[1543]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:17 volumio sudo[1543]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:17 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Jun 25 16:04:18 volumio kernel: ------------[ cut here ]------------
Jun 25 16:04:18 volumio kernel: bdi-(unknown) not registered
Jun 25 16:04:18 volumio kernel: WARNING: CPU: 0 PID: 1124 at fs/fs-writeback.c:2312 __mark_inode_dirty+0x25d/0x300
Jun 25 16:04:18 volumio kernel: Modules linked in: bnep bluetooth jitterentropy_rng hmac drbg ansi_cprng ecdh_generic ecc b43 cordic mac80211 snd_hda_codec_hdmi i915 intel_rapl_common x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel kvm sha256_generic cfg80211 nft_counter nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nft_compat nf_tables libcrc32c nfnetlink 8021q garp stp mrp llc irqbypass crc32_pclmul ssb rng_core libarc4 snd_hda_codec_realtek at24 snd_hda_codec_generic cec ledtrig_audio rc_core sg drm_kms_helper aesni_intel snd_hda_intel drm snd_intel_dspcfg uas snd_hda_codec snd_hda_core bcma snd_hwdep snd_pcm glue_helper libaes crypto_simd cryptd igb mei_me mei efi_pstore i2c_i801 snd_seq fb_sys_fops snd_seq_device snd_timer syscopyarea sysfillrect sysimgblt i2c_smbus i2c_algo_bit snd lpc_ich soundcore acpi_pad video backlight sunrpc efivarfs ip_tables autofs4 vfat fat ext4 crc32c_generic crc32c_intel crc16 mbcache jbd2 sata_via sata_sis pata_amd pata_via pata_sch
Jun 25 16:04:18 volumio kernel:  pata_atiixp ahci libahci usb_storage loop hid_generic hid_cherry usbhid hid sdhci_acpi sdhci_pci cqhci sdhci mmc_block nvme nvme_core fuse nls_utf8 nls_cp437 squashfs overlay
Jun 25 16:04:18 volumio kernel: CPU: 0 PID: 1124 Comm: ThreadPoolForeg Tainted: G        W         5.10.176-volumio #1
Jun 25 16:04:18 volumio kernel: Hardware name: To be filled by O.E.M. To be filled by O.E.M./CRESCENTBAY, BIOS 5.6.5 11/22/2017
Jun 25 16:04:18 volumio kernel: RIP: 0010:__mark_inode_dirty+0x25d/0x300
Jun 25 16:04:18 volumio kernel: Code: ff ff 48 8b 38 49 89 c4 f6 47 44 01 74 1e 48 8b 40 08 a8 01 75 16 e8 f2 d8 f4 ff 48 c7 c7 ab 45 ff 81 48 89 c6 e8 4c 1f 5f 00 <0f> 0b 48 8b 05 da c7 f4 00 48 89 83 c8 00 00 00 45 85 ff 74 0e 48
Jun 25 16:04:18 volumio kernel: RSP: 0018:ffffc90000937bb0 EFLAGS: 00010282
Jun 25 16:04:18 volumio kernel: RAX: 0000000000000000 RBX: ffff88802f98a648 RCX: 0000000000000027
Jun 25 16:04:18 volumio kernel: RDX: 0000000000000027 RSI: ffff88810041ba00 RDI: ffff88810041ba08
Jun 25 16:04:18 volumio kernel: RBP: ffffc90000937bd8 R08: 0000000000000000 R09: c0000000ffffefff
Jun 25 16:04:18 volumio kernel: R10: 0000000000000001 R11: ffffc90000937970 R12: ffff8880347f3c60
Jun 25 16:04:18 volumio kernel: R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
Jun 25 16:04:18 volumio kernel: FS:  00007f65a6ffd700(0000) GS:ffff888100400000(0000) knlGS:0000000000000000
Jun 25 16:04:18 volumio kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jun 25 16:04:18 volumio kernel: CR2: 00007f6590017f18 CR3: 0000000016eb6003 CR4: 00000000003706f0
Jun 25 16:04:18 volumio kernel: DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Jun 25 16:04:18 volumio kernel: DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Jun 25 16:04:18 volumio kernel: Call Trace:
Jun 25 16:04:18 volumio kernel:  generic_update_time+0xba/0xd0
Jun 25 16:04:18 volumio kernel:  inode_update_time+0x29/0x30
Jun 25 16:04:18 volumio kernel:  file_update_time+0xcc/0x120
Jun 25 16:04:18 volumio kernel:  file_modified+0x24/0x30
Jun 25 16:04:18 volumio kernel:  ext4_buffered_write_iter+0x5f/0x170 [ext4]
Jun 25 16:04:18 volumio kernel:  ext4_file_write_iter+0x61/0x8a0 [ext4]
Jun 25 16:04:18 volumio kernel:  do_iter_readv_writev+0x15b/0x1c0
Jun 25 16:04:18 volumio kernel:  do_iter_write+0x8e/0x1c0
Jun 25 16:04:18 volumio kernel:  vfs_iter_write+0x19/0x30
Jun 25 16:04:18 volumio kernel:  ovl_write_iter+0x2bc/0x430 [overlay]
Jun 25 16:04:18 volumio kernel:  new_sync_write+0x117/0x1b0
Jun 25 16:04:18 volumio kernel:  vfs_write+0x1cd/0x280
Jun 25 16:04:18 volumio kernel:  ksys_pwrite64+0x6a/0xb0
Jun 25 16:04:18 volumio kernel:  ? exc_page_fault+0x195/0x4c0
Jun 25 16:04:18 volumio kernel:  __x64_sys_pwrite64+0x1e/0x30
Jun 25 16:04:18 volumio kernel:  do_syscall_64+0x37/0x50
Jun 25 16:04:18 volumio kernel:  entry_SYSCALL_64_after_hwframe+0x61/0xc6
Jun 25 16:04:18 volumio kernel: RIP: 0033:0x7f65df773edf
Jun 25 16:04:18 volumio kernel: Code: 41 54 49 89 d4 55 48 89 f5 53 89 fb 48 83 ec 18 e8 c6 f2 ff ff 4d 89 ea 4c 89 e2 48 89 ee 41 89 c0 89 df b8 12 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 35 44 89 c7 48 89 44 24 08 e8 fc f2 ff ff 48
Jun 25 16:04:18 volumio kernel: RSP: 002b:00007f65a6ffb860 EFLAGS: 00000293 ORIG_RAX: 0000000000000012
Jun 25 16:04:18 volumio kernel: RAX: ffffffffffffffda RBX: 000000000000010d RCX: 00007f65df773edf
Jun 25 16:04:18 volumio kernel: RDX: 0000000000000004 RSI: 00007f65a6ffb8fc RDI: 000000000000010d
Jun 25 16:04:18 volumio kernel: RBP: 00007f65a6ffb8fc R08: 0000000000000000 R09: 0000000000000000
Jun 25 16:04:18 volumio kernel: R10: 0000000000005228 R11: 0000000000000293 R12: 0000000000000004
Jun 25 16:04:18 volumio kernel: R13: 0000000000005228 R14: 000000000000010d R15: 0000000000005228
Jun 25 16:04:18 volumio kernel: ---[ end trace 5085f4ddf1f9fafe ]---
Jun 25 16:04:18 volumio kernel: ------------[ cut here ]------------
Jun 25 16:04:18 volumio kernel: bdi-(unknown) not registered
Jun 25 16:04:18 volumio kernel: WARNING: CPU: 0 PID: 1124 at fs/fs-writeback.c:2312 __mark_inode_dirty+0x25d/0x300
Jun 25 16:04:18 volumio kernel: Modules linked in: bnep bluetooth jitterentropy_rng hmac drbg ansi_cprng ecdh_generic ecc b43 cordic mac80211 snd_hda_codec_hdmi i915 intel_rapl_common x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel kvm sha256_generic cfg80211 nft_counter nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nft_compat nf_tables libcrc32c nfnetlink 8021q garp stp mrp llc irqbypass crc32_pclmul ssb rng_core libarc4 snd_hda_codec_realtek at24 snd_hda_codec_generic cec ledtrig_audio rc_core sg drm_kms_helper aesni_intel snd_hda_intel drm snd_intel_dspcfg uas snd_hda_codec snd_hda_core bcma snd_hwdep snd_pcm glue_helper libaes crypto_simd cryptd igb mei_me mei efi_pstore i2c_i801 snd_seq fb_sys_fops snd_seq_device snd_timer syscopyarea sysfillrect sysimgblt i2c_smbus i2c_algo_bit snd lpc_ich soundcore acpi_pad video backlight sunrpc efivarfs ip_tables autofs4 vfat fat ext4 crc32c_generic crc32c_intel crc16 mbcache jbd2 sata_via sata_sis pata_amd pata_via pata_sch
Jun 25 16:04:18 volumio kernel:  pata_atiixp ahci libahci usb_storage loop hid_generic hid_cherry usbhid hid sdhci_acpi sdhci_pci cqhci sdhci mmc_block nvme nvme_core fuse nls_utf8 nls_cp437 squashfs overlay
Jun 25 16:04:18 volumio kernel: CPU: 0 PID: 1124 Comm: ThreadPoolForeg Tainted: G        W         5.10.176-volumio #1
Jun 25 16:04:18 volumio kernel: Hardware name: To be filled by O.E.M. To be filled by O.E.M./CRESCENTBAY, BIOS 5.6.5 11/22/2017
Jun 25 16:04:18 volumio kernel: RIP: 0010:__mark_inode_dirty+0x25d/0x300
Jun 25 16:04:18 volumio kernel: Code: ff ff 48 8b 38 49 89 c4 f6 47 44 01 74 1e 48 8b 40 08 a8 01 75 16 e8 f2 d8 f4 ff 48 c7 c7 ab 45 ff 81 48 89 c6 e8 4c 1f 5f 00 <0f> 0b 48 8b 05 da c7 f4 00 48 89 83 c8 00 00 00 45 85 ff 74 0e 48
Jun 25 16:04:18 volumio kernel: RSP: 0018:ffffc90000937bb0 EFLAGS: 00010282
Jun 25 16:04:18 volumio kernel: RAX: 0000000000000000 RBX: ffff88802fa59180 RCX: 0000000000000027
Jun 25 16:04:18 volumio kernel: RDX: 0000000000000027 RSI: ffff88810041ba00 RDI: ffff88810041ba08
Jun 25 16:04:18 volumio kernel: RBP: ffffc90000937bd8 R08: 0000000000000000 R09: c0000000ffffefff
Jun 25 16:04:18 volumio kernel: R10: 0000000000000001 R11: ffffc90000937970 R12: ffff8880347f3c60
Jun 25 16:04:18 volumio kernel: R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
Jun 25 16:04:18 volumio kernel: FS:  00007f65a6ffd700(0000) GS:ffff888100400000(0000) knlGS:0000000000000000
Jun 25 16:04:18 volumio kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jun 25 16:04:18 volumio kernel: CR2: 00007f65b002dbde CR3: 0000000016eb6003 CR4: 00000000003706f0
Jun 25 16:04:18 volumio kernel: DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Jun 25 16:04:18 volumio kernel: DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Jun 25 16:04:18 volumio kernel: Call Trace:
Jun 25 16:04:18 volumio kernel:  generic_update_time+0xba/0xd0
Jun 25 16:04:18 volumio kernel:  inode_update_time+0x29/0x30
Jun 25 16:04:18 volumio kernel:  file_update_time+0xcc/0x120
Jun 25 16:04:18 volumio kernel:  file_modified+0x24/0x30
Jun 25 16:04:18 volumio kernel:  ext4_buffered_write_iter+0x5f/0x170 [ext4]
Jun 25 16:04:18 volumio kernel:  ext4_file_write_iter+0x61/0x8a0 [ext4]
Jun 25 16:04:18 volumio kernel:  do_iter_readv_writev+0x15b/0x1c0
Jun 25 16:04:18 volumio kernel:  do_iter_write+0x8e/0x1c0
Jun 25 16:04:18 volumio kernel:  vfs_iter_write+0x19/0x30
Jun 25 16:04:18 volumio kernel:  ovl_write_iter+0x2bc/0x430 [overlay]
Jun 25 16:04:18 volumio kernel:  new_sync_write+0x117/0x1b0
Jun 25 16:04:18 volumio kernel:  vfs_write+0x1cd/0x280
Jun 25 16:04:18 volumio kernel:  ksys_pwrite64+0x6a/0xb0
Jun 25 16:04:18 volumio kernel:  ? exc_page_fault+0x195/0x4c0
Jun 25 16:04:18 volumio kernel:  __x64_sys_pwrite64+0x1e/0x30
Jun 25 16:04:18 volumio kernel:  do_syscall_64+0x37/0x50
Jun 25 16:04:18 volumio kernel:  entry_SYSCALL_64_after_hwframe+0x61/0xc6
Jun 25 16:04:18 volumio kernel: RIP: 0033:0x7f65df773edf
Jun 25 16:04:18 volumio kernel: Code: 41 54 49 89 d4 55 48 89 f5 53 89 fb 48 83 ec 18 e8 c6 f2 ff ff 4d 89 ea 4c 89 e2 48 89 ee 41 89 c0 89 df b8 12 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 35 44 89 c7 48 89 44 24 08 e8 fc f2 ff ff 48
Jun 25 16:04:18 volumio kernel: RSP: 002b:00007f65a6ffb860 EFLAGS: 00000293 ORIG_RAX: 0000000000000012
Jun 25 16:04:18 volumio kernel: RAX: ffffffffffffffda RBX: 000000000000010e RCX: 00007f65df773edf
Jun 25 16:04:18 volumio kernel: RDX: 0000000000000004 RSI: 00007f65a6ffb8fc RDI: 000000000000010e
Jun 25 16:04:18 volumio kernel: RBP: 00007f65a6ffb8fc R08: 0000000000000000 R09: 0000000000000000
Jun 25 16:04:18 volumio kernel: R10: 0000000000003a38 R11: 0000000000000293 R12: 0000000000000004
Jun 25 16:04:18 volumio kernel: R13: 0000000000003a38 R14: 000000000000010e R15: 0000000000003a38
Jun 25 16:04:18 volumio kernel: ---[ end trace 5085f4ddf1f9faff ]---
Jun 25 16:04:22 volumio kernel: EXT4-fs error: 72 callbacks suppressed
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:22 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:27 volumio kernel: EXT4-fs warning: 78 callbacks suppressed
Jun 25 16:04:27 volumio kernel: EXT4-fs warning (device sda3): dx_probe:792: inode #1580999: lblock 0: comm ThreadPoolForeg: error -5 reading directory block
Jun 25 16:04:28 volumio volumio[782]: error: MyVolumio Plugin failed to start in a timely fashion
Jun 25 16:04:28 volumio volumio[782]: info: BOOT COMPLETED
Jun 25 16:04:28 volumio volumio[782]:  [Metrics]  CommandRouter:  28s 530.01ms 
Jun 25 16:04:28 volumio volumio[782]: info: CoreCommandRouter::volumiosetStartupVolume
Jun 25 16:04:28 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 25 16:04:28 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:28 volumio volumio[782]: info: CoreCommandRouter::Close All Modals sent
Jun 25 16:04:28 volumio volumio[782]: info: CoreCommandRouter::Close All Modals sent
Jun 25 16:04:28 volumio kernel: snd_hda_intel 0000:00:03.0: IRQ timing workaround is activated for card #0. Suggest a bigger bdl_pos_adj.
Jun 25 16:04:28 volumio volumio[782]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Jun 25 16:04:28 volumio volumio[782]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jun 25 16:04:28 volumio volumio[782]: /volumio/app/startup.wav: Input/output error
Jun 25 16:04:28 volumio kernel: print_req_error: 108 callbacks suppressed
Jun 25 16:04:28 volumio kernel: blk_update_request: I/O error, dev loop0, sector 1551566 op 0x0:(READ) flags 0x800 phys_seg 24 prio class 0
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Failed to read block 0x2f599dbf: -5
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read data cache entry [2f599dbf]
Jun 25 16:04:28 volumio kernel: SQUASHFS error: Unable to read page, block 2f599dbf, size 17114
Jun 25 16:04:28 volumio kernel: EXT4-fs error: 16 callbacks suppressed
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581131: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:28 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jun 25 16:04:29 volumio volumio[782]: info: Version has changed, forcing UI Reload
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::Reload Ui
Jun 25 16:04:29 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:29 volumio volumio[782]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 3
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Jun 25 16:04:29 volumio volumio[782]: info: Received Get System Info
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 25 16:04:29 volumio volumio[782]: info: Discovery: Getting this device information
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::volumioGetState
Jun 25 16:04:29 volumio volumio[782]: info: CorePlayQueue::getTrack 0
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 25 16:04:29 volumio volumio-remote-updater[385]: No test mode
Jun 25 16:04:29 volumio volumio-remote-updater[385]: No alpha test mode
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 25 16:04:29 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 25 16:04:30 volumio volumio[782]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES


Fix for lost MPD database after reboot
 
Fix for TIDAL authentication refresh
 
Fix TIDAL low quality (AAC) playback
 
Fix for DLNA Server discovery
Fix for Plugins installation


NEW ADDITIONS


Update Bluez to v5.83
 
Update TIDAL SDK
 
Add Bluetooth A2DP playback
 ","title":"Update v3.886","updateavailable":true}
Jun 25 16:04:30 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jun 25 16:04:30 volumio volumio[782]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/system_controller/system/config.json'
Jun 25 16:04:31 volumio volumio[782]: error: Failed to update update history file: function createApplication() {
Jun 25 16:04:31 volumio volumio[782]:   var app = function(req, res, next) {
Jun 25 16:04:31 volumio volumio[782]:     app.handle(req, res, next);
Jun 25 16:04:31 volumio volumio[782]:   };
Jun 25 16:04:31 volumio volumio[782]:   mixin(app, EventEmitter.prototype, false);
Jun 25 16:04:31 volumio volumio[782]:   mixin(app, proto, false);
Jun 25 16:04:31 volumio volumio[782]:   // expose the prototype that will get set on requests
Jun 25 16:04:31 volumio volumio[782]:   app.request = Object.create(req, {
Jun 25 16:04:31 volumio volumio[782]:     app: { configurable: true, enumerable: true, writable: true, value: app }
Jun 25 16:04:31 volumio volumio[782]:   })
Jun 25 16:04:31 volumio volumio[782]:   // expose the prototype that will get set on responses
Jun 25 16:04:31 volumio volumio[782]:   app.response = Object.create(res, {
Jun 25 16:04:31 volumio volumio[782]:     app: { configurable: true, enumerable: true, writable: true, value: app }
Jun 25 16:04:31 volumio volumio[782]:   })
Jun 25 16:04:31 volumio volumio[782]:   app.init();
Jun 25 16:04:31 volumio volumio[782]:   return app;
Jun 25 16:04:31 volumio volumio[782]: }
Jun 25 16:04:31 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 25 16:04:33 volumio kernel: EXT4-fs error: 207 callbacks suppressed
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:33 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:34 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:34 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:34 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Jun 25 16:04:34 volumio kernel: EXT4-fs warning (device sda3): htree_dirblock_to_tree:1042: inode #1581218: lblock 0: comm systemd: error -5 reading directory block
Jun 25 16:04:35 volumio kernel: EXT4-fs warning (device sda3): dx_probe:792: inode #1580999: lblock 0: comm ThreadPoolForeg: error -5 reading directory block
Jun 25 16:04:37 volumio kernel: EXT4-fs warning (device sda3): dx_probe:792: inode #1580999: lblock 0: comm ThreadPoolForeg: error -5 reading directory block
Jun 25 16:04:38 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 25 16:04:38 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 25 16:04:38 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 25 16:04:39 volumio kernel: EXT4-fs error: 21 callbacks suppressed
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:39 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:44 volumio kernel: EXT4-fs error: 12 callbacks suppressed
Jun 25 16:04:44 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:44 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:44 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: usb 2-4: new low-speed USB device number 5 using xhci_hcd
Jun 25 16:04:46 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581232: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:46 volumio kernel: usb 2-4: New USB device found, idVendor=093a, idProduct=2510, bcdDevice= 1.00
Jun 25 16:04:46 volumio kernel: usb 2-4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jun 25 16:04:46 volumio kernel: usb 2-4: Product: USB Optical Mouse
Jun 25 16:04:46 volumio kernel: usb 2-4: Manufacturer: PixArt
Jun 25 16:04:46 volumio kernel: input: PixArt USB Optical Mouse as /devices/pci0000:00/0000:00:14.0/usb2/2-4/2-4:1.0/0003:093A:2510.0001/input/input12
Jun 25 16:04:46 volumio kernel: hid-generic 0003:093A:2510.0001: input,hidraw0: USB HID v1.11 Mouse [PixArt USB Optical Mouse] on usb-0000:00:14.0-4/input0
Jun 25 16:04:46 volumio kernel: blk_update_request: I/O error, dev loop0, sector 400130 op 0x0:(READ) flags 0x800 phys_seg 9 prio class 0
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Failed to read block 0xc3607ee: -5
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [c3607ee]
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read page, block c3607ee, size 822f
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [c3607ee]
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read page, block c3607ee, size 822f
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [c3607ee]
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read page, block c3607ee, size 822f
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [c3607ee]
Jun 25 16:04:46 volumio kernel: SQUASHFS error: Unable to read page, block c3607ee, size 822f
Jun 25 16:04:46 volumio systemd-udevd[1556]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:04:46 volumio systemd-udevd[1555]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 25 16:04:47 volumio kernel: EXT4-fs warning (device sda3): dx_probe:792: inode #1580999: lblock 0: comm ThreadPoolForeg: error -5 reading directory block
Jun 25 16:04:51 volumio kernel: blk_update_request: I/O error, dev loop0, sector 1060904 op 0x0:(READ) flags 0x800 phys_seg 7 prio class 0
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Failed to read block 0x20605073: -5
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [20605073]
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read page, block 20605073, size 60c9
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [20605073]
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read page, block 20605073, size 60c9
Jun 25 16:04:51 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Jun 25 16:04:51 volumio volumio[782]: info: Loading i18n strings for locale en
Jun 25 16:04:51 volumio volumio[782]: Updating browse sources language
Jun 25 16:04:51 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 25 16:04:51 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Jun 25 16:04:51 volumio volumio[782]: info: Setting timezone to UTC
Jun 25 16:04:51 volumio sudo[1562]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Jun 25 16:04:51 volumio sudo[1562]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:51 volumio sudo[1562]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:51 volumio volumio[782]: /usr/bin/unlink: cannot unlink '/etc/localtime': Read-only file system
Jun 25 16:04:51 volumio volumio[782]: error: Could not set timezone: Error: Command failed: /usr/bin/sudo /usr/bin/unlink /etc/localtime
Jun 25 16:04:51 volumio volumio[782]: /usr/bin/unlink: cannot unlink '/etc/localtime': Read-only file system
Jun 25 16:04:51 volumio sudo[1565]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
Jun 25 16:04:51 volumio sudo[1565]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:51 volumio sudo[1565]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:51 volumio volumio[782]: sudo: unable to execute /usr/bin/timedatectl: Input/output error
Jun 25 16:04:51 volumio volumio[782]: info: Could not set timezone, retrying
Jun 25 16:04:51 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Jun 25 16:04:51 volumio kernel: blk_update_request: I/O error, dev loop0, sector 756992 op 0x0:(READ) flags 0x800 phys_seg 13 prio class 0
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Failed to read block 0x171a026b: -5
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [171a026b]
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read page, block 171a026b, size c310
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [171a026b]
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read page, block 171a026b, size c310
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [171a026b]
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read page, block 171a026b, size c310
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [171a026b]
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read page, block 171a026b, size c310
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [171a026b]
Jun 25 16:04:51 volumio kernel: SQUASHFS error: Unable to read page, block 171a026b, size c310
Jun 25 16:04:51 volumio volumio[782]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Jun 25 16:04:51 volumio sudo[1568]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 25 16:04:51 volumio sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:51 volumio sudo[1568]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:51 volumio volumio[782]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Jun 25 16:04:51 volumio volumio[782]: wlan0     Interface doesn't support scanning : Operation not supported
Jun 25 16:04:51 volumio volumio[782]: info: Cannot use regular scanning, forcing with ap-force
Jun 25 16:04:51 volumio sudo[1571]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Jun 25 16:04:51 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:52 volumio kernel: EXT4-fs error: 9 callbacks suppressed
Jun 25 16:04:52 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:52 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:52 volumio kernel: EXT4-fs error (device sda3): __ext4_find_entry:1581: inode #1581062: comm ThreadPoolForeg: reading directory lblock 0
Jun 25 16:04:52 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:52 volumio volumio[782]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/miscellanea/appearance/config.json'
Jun 25 16:04:52 volumio sudo[1574]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC
Jun 25 16:04:52 volumio sudo[1574]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 25 16:04:52 volumio sudo[1574]: pam_unix(sudo:session): session closed for user root
Jun 25 16:04:52 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [171a026b]
Jun 25 16:04:52 volumio kernel: SQUASHFS error: Unable to read page, block 171a026b, size c310
Jun 25 16:04:52 volumio volumio[782]: sudo: unable to execute /usr/bin/timedatectl: Input/output error
Jun 25 16:04:52 volumio volumio[782]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 25 16:04:52 volumio volumio[782]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'UTC'
Jun 25 16:04:52 volumio volumio[782]: sudo: unable to execute /usr/bin/timedatectl: Input/output error
Jun 25 16:04:52 volumio volumio[782]:     at checkExecSyncError (child_process.js:790:11)
Jun 25 16:04:52 volumio volumio[782]:     at execSync (child_process.js:863:15)
Jun 25 16:04:52 volumio volumio[782]:     at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1437:9)
Jun 25 16:04:52 volumio volumio[782]:     at listOnTimeout (internal/timers.js:557:17)
Jun 25 16:04:52 volumio volumio[782]:     at processTimers (internal/timers.js:500:7) {
Jun 25 16:04:52 volumio volumio[782]:   status: 1,
Jun 25 16:04:52 volumio volumio[782]:   signal: null,
Jun 25 16:04:52 volumio volumio[782]:   output: [
Jun 25 16:04:52 volumio volumio[782]:     null,
Jun 25 16:04:52 volumio volumio[782]:     '',
Jun 25 16:04:52 volumio volumio[782]:     'sudo: unable to execute /usr/bin/timedatectl: Input/output error\n'
Jun 25 16:04:52 volumio volumio[782]:   ],
Jun 25 16:04:52 volumio volumio[782]:   pid: 1573,
Jun 25 16:04:52 volumio volumio[782]:   stdout: '',
Jun 25 16:04:52 volumio volumio[782]:   stderr: 'sudo: unable to execute /usr/bin/timedatectl: Input/output error\n'
Jun 25 16:04:52 volumio volumio[782]: }
Jun 25 16:04:52 volumio volumio[782]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 25 16:04:52 volumio sudo[1585]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-06-25 16:03
Jun 25 16:04:52 volumio sudo[1585]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 06:04:32 PM CEST"
VOLUMIO_VERSION="3.512"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="dd58c1c2d5a97e584de8089531ce548f"