-- Logs begin at Sun 2024-03-31 03:04:28 +03, end at Sun 2024-03-31 03:05:09 +03. -- Mar 31 03:04:28 balabala kernel: Booting Linux on physical CPU 0x0 Mar 31 03:04:28 balabala kernel: Linux version 6.1.69-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1710 SMP Thu Dec 21 13:17:38 GMT 2023 Mar 31 03:04:28 balabala kernel: CPU: ARMv7 Processor [410fd083] revision 3 (ARMv7), cr=30c5383d Mar 31 03:04:28 balabala kernel: CPU: div instructions available: patching division code Mar 31 03:04:28 balabala kernel: CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache Mar 31 03:04:28 balabala kernel: OF: fdt: Machine model: Raspberry Pi 4 Model B Rev 1.5 Mar 31 03:04:28 balabala kernel: random: crng init done Mar 31 03:04:28 balabala kernel: Memory policy: Data cache writealloc Mar 31 03:04:28 balabala kernel: Reserved memory: created CMA memory pool at 0x000000002a000000, size 64 MiB Mar 31 03:04:28 balabala kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Mar 31 03:04:28 balabala kernel: Zone ranges: Mar 31 03:04:28 balabala kernel: DMA [mem 0x0000000000000000-0x000000002fffffff] Mar 31 03:04:28 balabala kernel: Normal empty Mar 31 03:04:28 balabala kernel: HighMem [mem 0x0000000030000000-0x00000000fbffffff] Mar 31 03:04:28 balabala kernel: Movable zone start for each node Mar 31 03:04:28 balabala kernel: Early memory node ranges Mar 31 03:04:28 balabala kernel: node 0: [mem 0x0000000000000000-0x0000000037ffffff] Mar 31 03:04:28 balabala kernel: node 0: [mem 0x0000000040000000-0x00000000fbffffff] Mar 31 03:04:28 balabala kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff] Mar 31 03:04:28 balabala kernel: percpu: Embedded 17 pages/cpu s37012 r8192 d24428 u69632 Mar 31 03:04:28 balabala kernel: pcpu-alloc: s37012 r8192 d24428 u69632 alloc=17*4096 Mar 31 03:04:28 balabala kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Mar 31 03:04:28 balabala kernel: Built 1 zonelists, mobility grouping on. Total pages: 997696 Mar 31 03:04:28 balabala kernel: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=D8:3A:DD:76:C5:7A vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 Mar 31 03:04:28 balabala kernel: Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. Mar 31 03:04:28 balabala kernel: Unknown kernel command line parameters "splash imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh bootdelay=5", will be passed to user space. Mar 31 03:04:28 balabala kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) Mar 31 03:04:28 balabala kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 31 03:04:28 balabala kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 31 03:04:28 balabala kernel: software IO TLB: area num 4. Mar 31 03:04:28 balabala kernel: software IO TLB: mapped [mem 0x0000000023c90000-0x0000000027c90000] (64MB) Mar 31 03:04:28 balabala kernel: Memory: 3797388K/3997696K available (10240K kernel code, 1505K rwdata, 3388K rodata, 2048K init, 637K bss, 134772K reserved, 65536K cma-reserved, 3211264K highmem) Mar 31 03:04:28 balabala kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Mar 31 03:04:28 balabala kernel: ftrace: allocating 37226 entries in 110 pages Mar 31 03:04:28 balabala kernel: ftrace: allocated 110 pages with 5 groups Mar 31 03:04:28 balabala kernel: trace event string verifier disabled Mar 31 03:04:28 balabala kernel: rcu: Hierarchical RCU implementation. Mar 31 03:04:28 balabala kernel: Rude variant of Tasks RCU enabled. Mar 31 03:04:28 balabala kernel: Tracing variant of Tasks RCU enabled. Mar 31 03:04:28 balabala kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. Mar 31 03:04:28 balabala kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Mar 31 03:04:28 balabala kernel: GIC: Using split EOI/Deactivate mode Mar 31 03:04:28 balabala kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 31 03:04:28 balabala kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Mar 31 03:04:28 balabala kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Mar 31 03:04:28 balabala kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Mar 31 03:04:28 balabala kernel: Switching to timer-based delay loop, resolution 18ns Mar 31 03:04:28 balabala kernel: Console: colour dummy device 80x30 Mar 31 03:04:28 balabala kernel: printk: console [tty1] enabled Mar 31 03:04:28 balabala kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=540000) Mar 31 03:04:28 balabala kernel: CPU: Testing write buffer coherency: ok Mar 31 03:04:28 balabala kernel: CPU0: Spectre BHB: enabling loop workaround for all CPUs Mar 31 03:04:28 balabala kernel: pid_max: default: 32768 minimum: 301 Mar 31 03:04:28 balabala kernel: LSM: Security Framework initializing Mar 31 03:04:28 balabala kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Mar 31 03:04:28 balabala kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) Mar 31 03:04:28 balabala kernel: cgroup: Disabling memory control group subsystem Mar 31 03:04:28 balabala kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Mar 31 03:04:28 balabala kernel: cblist_init_generic: Setting adjustable number of callback queues. Mar 31 03:04:28 balabala kernel: cblist_init_generic: Setting shift to 2 and lim to 1. Mar 31 03:04:28 balabala kernel: cblist_init_generic: Setting adjustable number of callback queues. Mar 31 03:04:28 balabala kernel: cblist_init_generic: Setting shift to 2 and lim to 1. Mar 31 03:04:28 balabala kernel: Setting up static identity map for 0x200000 - 0x20003c Mar 31 03:04:28 balabala kernel: rcu: Hierarchical SRCU implementation. Mar 31 03:04:28 balabala kernel: rcu: Max phase no-delay instances is 1000. Mar 31 03:04:28 balabala kernel: smp: Bringing up secondary CPUs ... Mar 31 03:04:28 balabala kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Mar 31 03:04:28 balabala kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Mar 31 03:04:28 balabala kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Mar 31 03:04:28 balabala kernel: smp: Brought up 1 node, 4 CPUs Mar 31 03:04:28 balabala kernel: SMP: Total of 4 processors activated (432.00 BogoMIPS). Mar 31 03:04:28 balabala kernel: CPU: All CPU(s) started in HYP mode. Mar 31 03:04:28 balabala kernel: CPU: Virtualization extensions available. Mar 31 03:04:28 balabala kernel: devtmpfs: initialized Mar 31 03:04:28 balabala kernel: VFP support v0.3: implementor 41 architecture 3 part 40 variant 8 rev 0 Mar 31 03:04:28 balabala kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Mar 31 03:04:28 balabala kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Mar 31 03:04:28 balabala kernel: pinctrl core: initialized pinctrl subsystem Mar 31 03:04:28 balabala kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 31 03:04:28 balabala kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations Mar 31 03:04:28 balabala kernel: audit: initializing netlink subsys (disabled) Mar 31 03:04:28 balabala kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Mar 31 03:04:28 balabala kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 31 03:04:28 balabala kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Mar 31 03:04:28 balabala kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Mar 31 03:04:28 balabala kernel: Serial: AMBA PL011 UART driver Mar 31 03:04:28 balabala kernel: bcm2835-mbox fe00b880.mailbox: mailbox enabled Mar 31 03:04:28 balabala kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:39:16, variant start Mar 31 03:04:28 balabala kernel: raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7 Mar 31 03:04:28 balabala kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Mar 31 03:04:28 balabala kernel: bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 Mar 31 03:04:28 balabala kernel: SCSI subsystem initialized Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver usbfs Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver hub Mar 31 03:04:28 balabala kernel: usbcore: registered new device driver usb Mar 31 03:04:28 balabala kernel: usb_phy_generic phy: supply vcc not found, using dummy regulator Mar 31 03:04:28 balabala kernel: pps_core: LinuxPPS API ver. 1 registered Mar 31 03:04:28 balabala kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 31 03:04:28 balabala kernel: PTP clock support registered Mar 31 03:04:28 balabala kernel: vgaarb: loaded Mar 31 03:04:28 balabala kernel: clocksource: Switched to clocksource arch_sys_counter Mar 31 03:04:28 balabala kernel: VFS: Disk quotas dquot_6.6.0 Mar 31 03:04:28 balabala kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Mar 31 03:04:28 balabala kernel: FS-Cache: Loaded Mar 31 03:04:28 balabala kernel: CacheFiles: Loaded Mar 31 03:04:28 balabala kernel: NET: Registered PF_INET protocol family Mar 31 03:04:28 balabala kernel: IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) Mar 31 03:04:28 balabala kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear) Mar 31 03:04:28 balabala kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 31 03:04:28 balabala kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) Mar 31 03:04:28 balabala kernel: TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) Mar 31 03:04:28 balabala kernel: TCP: Hash tables configured (established 8192 bind 8192) Mar 31 03:04:28 balabala kernel: UDP hash table entries: 512 (order: 2, 16384 bytes, linear) Mar 31 03:04:28 balabala kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) Mar 31 03:04:28 balabala kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 31 03:04:28 balabala kernel: RPC: Registered named UNIX socket transport module. Mar 31 03:04:28 balabala kernel: RPC: Registered udp transport module. Mar 31 03:04:28 balabala kernel: RPC: Registered tcp transport module. Mar 31 03:04:28 balabala kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Mar 31 03:04:28 balabala kernel: PCI: CLS 0 bytes, default 64 Mar 31 03:04:28 balabala kernel: Trying to unpack rootfs image as initramfs... Mar 31 03:04:28 balabala kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available Mar 31 03:04:28 balabala kernel: Initialise system trusted keyrings Mar 31 03:04:28 balabala kernel: workingset: timestamp_bits=14 max_order=20 bucket_order=6 Mar 31 03:04:28 balabala kernel: zbud: loaded Mar 31 03:04:28 balabala kernel: NFS: Registering the id_resolver key type Mar 31 03:04:28 balabala kernel: Key type id_resolver registered Mar 31 03:04:28 balabala kernel: Key type id_legacy registered Mar 31 03:04:28 balabala kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Mar 31 03:04:28 balabala kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Mar 31 03:04:28 balabala kernel: Key type asymmetric registered Mar 31 03:04:28 balabala kernel: Asymmetric key parser 'x509' registered Mar 31 03:04:28 balabala kernel: bounce: pool size: 64 pages Mar 31 03:04:28 balabala kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Mar 31 03:04:28 balabala kernel: io scheduler mq-deadline registered Mar 31 03:04:28 balabala kernel: io scheduler kyber registered Mar 31 03:04:28 balabala kernel: brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: Mar 31 03:04:28 balabala kernel: brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] Mar 31 03:04:28 balabala kernel: brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 Mar 31 03:04:28 balabala kernel: brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00ffffffff -> 0x0400000000 Mar 31 03:04:28 balabala kernel: brcm-pcie fd500000.pcie: setting SCB_ACCESS_EN, READ_UR_MODE, MAX_BURST_SIZE Mar 31 03:04:28 balabala kernel: brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 Mar 31 03:04:28 balabala kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Mar 31 03:04:28 balabala kernel: pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) Mar 31 03:04:28 balabala kernel: pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 Mar 31 03:04:28 balabala kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Mar 31 03:04:28 balabala kernel: PCI: bus0: Fast back to back transfers disabled Mar 31 03:04:28 balabala kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Mar 31 03:04:28 balabala kernel: pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator Mar 31 03:04:28 balabala kernel: pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator Mar 31 03:04:28 balabala kernel: pci_bus 0000:01: supply vpcie12v not found, using dummy regulator Mar 31 03:04:28 balabala kernel: brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) Mar 31 03:04:28 balabala kernel: pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 Mar 31 03:04:28 balabala kernel: pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Mar 31 03:04:28 balabala kernel: pci 0000:01:00.0: PME# supported from D0 D3hot Mar 31 03:04:28 balabala kernel: PCI: bus1: Fast back to back transfers disabled Mar 31 03:04:28 balabala kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Mar 31 03:04:28 balabala kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] Mar 31 03:04:28 balabala kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] Mar 31 03:04:28 balabala kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Mar 31 03:04:28 balabala kernel: pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] Mar 31 03:04:28 balabala kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Mar 31 03:04:28 balabala kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 45 Mar 31 03:04:28 balabala kernel: bcm2708_fb soc:fb: FB found 1 display(s) Mar 31 03:04:28 balabala kernel: Console: switching to colour frame buffer device 80x30 Mar 31 03:04:28 balabala kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 640x480 Mar 31 03:04:28 balabala kernel: iproc-rng200 fe104000.rng: hwrng registered Mar 31 03:04:28 balabala kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) Mar 31 03:04:28 balabala kernel: brd: module loaded Mar 31 03:04:28 balabala kernel: loop: module loaded Mar 31 03:04:28 balabala kernel: Loading iSCSI transport class v2.0-870. Mar 31 03:04:28 balabala kernel: bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 Mar 31 03:04:28 balabala kernel: Freeing initrd memory: 13628K Mar 31 03:04:28 balabala kernel: unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus Mar 31 03:04:28 balabala kernel: usbcore: registered new device driver r8152-cfgselector Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver r8152 Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver lan78xx Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver smsc95xx Mar 31 03:04:28 balabala kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Mar 31 03:04:28 balabala kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 Mar 31 03:04:28 balabala kernel: xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0b00040000000890 Mar 31 03:04:28 balabala kernel: xhci_hcd 0000:01:00.0: xHCI Host Controller Mar 31 03:04:28 balabala kernel: xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 Mar 31 03:04:28 balabala kernel: xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed Mar 31 03:04:28 balabala kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 Mar 31 03:04:28 balabala kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 31 03:04:28 balabala kernel: usb usb1: Product: xHCI Host Controller Mar 31 03:04:28 balabala kernel: usb usb1: Manufacturer: Linux 6.1.69-v7l+ xhci-hcd Mar 31 03:04:28 balabala kernel: usb usb1: SerialNumber: 0000:01:00.0 Mar 31 03:04:28 balabala kernel: hub 1-0:1.0: USB hub found Mar 31 03:04:28 balabala kernel: hub 1-0:1.0: 1 port detected Mar 31 03:04:28 balabala kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01 Mar 31 03:04:28 balabala kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 31 03:04:28 balabala kernel: usb usb2: Product: xHCI Host Controller Mar 31 03:04:28 balabala kernel: usb usb2: Manufacturer: Linux 6.1.69-v7l+ xhci-hcd Mar 31 03:04:28 balabala kernel: usb usb2: SerialNumber: 0000:01:00.0 Mar 31 03:04:28 balabala kernel: hub 2-0:1.0: USB hub found Mar 31 03:04:28 balabala kernel: hub 2-0:1.0: 4 ports detected Mar 31 03:04:28 balabala kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Mar 31 03:04:28 balabala kernel: dwc_otg: FIQ enabled Mar 31 03:04:28 balabala kernel: dwc_otg: NAK holdoff enabled Mar 31 03:04:28 balabala kernel: dwc_otg: FIQ split-transaction FSM enabled Mar 31 03:04:28 balabala kernel: Module dwc_common_port init Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver uas Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver usb-storage Mar 31 03:04:28 balabala kernel: mousedev: PS/2 mouse device common for all mice Mar 31 03:04:28 balabala kernel: sdhci: Secure Digital Host Controller Interface driver Mar 31 03:04:28 balabala kernel: sdhci: Copyright(c) Pierre Ossman Mar 31 03:04:28 balabala kernel: sdhci-pltfm: SDHCI platform and OF driver helper Mar 31 03:04:28 balabala kernel: ledtrig-cpu: registered to indicate activity on CPUs Mar 31 03:04:28 balabala kernel: hid: raw HID events driver (C) Jiri Kosina Mar 31 03:04:28 balabala kernel: usbcore: registered new interface driver usbhid Mar 31 03:04:28 balabala kernel: usbhid: USB HID core driver Mar 31 03:04:28 balabala kernel: Initializing XFRM netlink socket Mar 31 03:04:28 balabala kernel: NET: Registered PF_PACKET protocol family Mar 31 03:04:28 balabala kernel: Key type dns_resolver registered Mar 31 03:04:28 balabala kernel: Registering SWP/SWPB emulation handler Mar 31 03:04:28 balabala kernel: registered taskstats version 1 Mar 31 03:04:28 balabala kernel: Loading compiled-in X.509 certificates Mar 31 03:04:28 balabala kernel: Key type .fscrypt registered Mar 31 03:04:28 balabala kernel: Key type fscrypt-provisioning registered Mar 31 03:04:28 balabala kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Mar 31 03:04:28 balabala kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Mar 31 03:04:28 balabala kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Mar 31 03:04:28 balabala kernel: serial serial0: tty port ttyAMA1 registered Mar 31 03:04:28 balabala kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Mar 31 03:04:28 balabala kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Mar 31 03:04:28 balabala kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Mar 31 03:04:28 balabala kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Mar 31 03:04:28 balabala kernel: of_cfs_init Mar 31 03:04:28 balabala kernel: of_cfs_init: OK Mar 31 03:04:28 balabala kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Mar 31 03:04:28 balabala kernel: Freeing unused kernel image (initmem) memory: 2048K Mar 31 03:04:28 balabala kernel: Run /init as init process Mar 31 03:04:28 balabala kernel: with arguments: Mar 31 03:04:28 balabala kernel: /init Mar 31 03:04:28 balabala kernel: splash Mar 31 03:04:28 balabala kernel: with environment: Mar 31 03:04:28 balabala kernel: HOME=/ Mar 31 03:04:28 balabala kernel: TERM=linux Mar 31 03:04:28 balabala kernel: imgpart=/dev/mmcblk0p2 Mar 31 03:04:28 balabala kernel: imgfile=/volumio_current.sqsh Mar 31 03:04:28 balabala kernel: bootdelay=5 Mar 31 03:04:28 balabala kernel: mmc1: new high speed SDIO card at address 0001 Mar 31 03:04:28 balabala kernel: mmc0: new ultra high speed DDR50 SDXC card at address 5048 Mar 31 03:04:28 balabala kernel: mmcblk0: mmc0:5048 SD64G 58.0 GiB Mar 31 03:04:28 balabala kernel: mmcblk0: p1 p2 p3 Mar 31 03:04:28 balabala kernel: mmcblk0: mmc0:5048 SD64G 58.0 GiB Mar 31 03:04:28 balabala kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Mar 31 03:04:28 balabala initramfs: Booting Volumio for BCM2711 Mar 31 03:04:28 balabala initramfs: This script mounts rootfs RO with an overlay RW layer. Mar 31 03:04:28 balabala kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 31 03:04:28 balabala initramfs: IMGPART=/dev/mmcblk0p2 Mar 31 03:04:28 balabala initramfs: IMGFILE=/volumio_current.sqsh Mar 31 03:04:28 balabala initramfs: Boot delay (except first time) will be 5 seconds Mar 31 03:04:28 balabala initramfs: /dev/mmcblk0p2: Mar 31 03:04:28 balabala kernel: EXT4-fs (mmcblk0p2): recovery complete Mar 31 03:04:28 balabala kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Mar 31 03:04:28 balabala initramfs: Doing a 5 second delay here to give kernel load a headstart Mar 31 03:04:28 balabala kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Mar 31 03:04:28 balabala kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Mar 31 03:04:28 balabala kernel: usb 1-1: Product: USB2.0 Hub Mar 31 03:04:28 balabala kernel: hub 1-1:1.0: USB hub found Mar 31 03:04:28 balabala kernel: hub 1-1:1.0: 4 ports detected Mar 31 03:04:28 balabala initramfs: Checking for USB updates Mar 31 03:04:28 balabala initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Mar 31 03:04:28 balabala kernel: loop0: detected capacity change from 0 to 967536 Mar 31 03:04:28 balabala kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 31 03:04:28 balabala kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 31 03:04:28 balabala kernel: EXT4-fs (mmcblk0p3): recovery complete Mar 31 03:04:28 balabala kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Mar 31 03:04:28 balabala initramfs: With Option: Mar 31 03:04:28 balabala initramfs: VOLUMIO_VERSION="3.631" Mar 31 03:04:28 balabala initramfs: Finish initramfs, continue booting Volumio Mar 31 03:04:28 balabala systemd[1]: System time before build time, advancing clock. Mar 31 03:04:28 balabala kernel: NET: Registered PF_INET6 protocol family Mar 31 03:04:28 balabala kernel: Segment Routing with IPv6 Mar 31 03:04:28 balabala kernel: In-situ OAM (IOAM) with IPv6 Mar 31 03:04:28 balabala 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) Mar 31 03:04:28 balabala systemd[1]: Detected architecture arm. Mar 31 03:04:28 balabala systemd[1]: Set hostname to . Mar 31 03:04:28 balabala 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. Mar 31 03:04:28 balabala systemd[1]: Listening on initctl Compatibility Named Pipe. Mar 31 03:04:28 balabala systemd[1]: Created slice system-getty.slice. Mar 31 03:04:28 balabala systemd[1]: Created slice User and Session Slice. Mar 31 03:04:28 balabala systemd[1]: Reached target Slices. Mar 31 03:04:28 balabala systemd[1]: Listening on RPCbind Server Activation Socket. Mar 31 03:04:28 balabala systemd[1]: Listening on Journal Audit Socket. Mar 31 03:04:28 balabala kernel: i2c_dev: i2c /dev entries driver Mar 31 03:04:28 balabala systemd-journald[205]: Journal started Mar 31 03:04:28 balabala systemd-journald[205]: Runtime journal (/run/log/journal/ba41094955353179f46b1ad365cba63d) is 3.7M, max 30.0M, 26.2M free. Mar 31 03:04:28 balabala systemd-modules-load[200]: Inserted module 'i2c_dev' Mar 31 03:04:28 balabala fake-hwclock[204]: Sun Mar 31 00:04:28 UTC 2024 Mar 31 03:04:28 balabala systemd[1]: Started Apply Kernel Variables. Mar 31 03:04:28 balabala systemd[1]: Started Create System Users. Mar 31 03:04:28 balabala systemd[1]: Starting Create Static Device Nodes in /dev... Mar 31 03:04:28 balabala systemd[1]: Started Create Static Device Nodes in /dev. Mar 31 03:04:28 balabala systemd[1]: Reached target Local File Systems (Pre). Mar 31 03:04:28 balabala systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 31 03:04:28 balabala systemd[1]: Mounting /var/log... Mar 31 03:04:28 balabala systemd[1]: Mounting /var/spool/cups... Mar 31 03:04:28 balabala systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 31 03:04:28 balabala systemd[1]: Mounting /tmp... Mar 31 03:04:28 balabala systemd[1]: Starting udev Kernel Device Manager... Mar 31 03:04:28 balabala systemd[1]: Mounted /var/log. Mar 31 03:04:28 balabala systemd[1]: Mounted /var/spool/cups. Mar 31 03:04:28 balabala systemd[1]: Mounted /tmp. Mar 31 03:04:28 balabala systemd[1]: Mounting /var/spool/cups/tmp... Mar 31 03:04:28 balabala systemd[1]: Starting Flush Journal to Persistent Storage... Mar 31 03:04:28 balabala systemd[1]: Mounted /var/spool/cups/tmp. Mar 31 03:04:28 balabala systemd-udevd[233]: Network interface NamePolicy= disabled on kernel command line, ignoring. Mar 31 03:04:28 balabala systemd[1]: Started udev Coldplug all Devices. Mar 31 03:04:28 balabala systemd[1]: Starting Helper to synchronize boot up for ifupdown... Mar 31 03:04:28 balabala systemd[1]: Started udev Kernel Device Manager. Mar 31 03:04:28 balabala systemd-journald[205]: Runtime journal (/run/log/journal/ba41094955353179f46b1ad365cba63d) is 3.7M, max 30.0M, 26.2M free. Mar 31 03:04:28 balabala systemd[1]: Starting Show Plymouth Boot Screen... Mar 31 03:04:28 balabala systemd[1]: Started Flush Journal to Persistent Storage. Mar 31 03:04:28 balabala systemd[1]: Started Helper to synchronize boot up for ifupdown. Mar 31 03:04:28 balabala systemd[1]: Received SIGRTMIN+20 from PID 256 (plymouthd). Mar 31 03:04:28 balabala systemd[1]: Started Show Plymouth Boot Screen. Mar 31 03:04:28 balabala systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 31 03:04:28 balabala systemd[1]: Reached target Paths. Mar 31 03:04:28 balabala systemd[1]: Reached target Local Encrypted Volumes. Mar 31 03:04:28 balabala systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 31 03:04:28 balabala systemd-udevd[242]: Using default interface naming scheme 'v240'. Mar 31 03:04:28 balabala kernel: mc: Linux media interface: v0.10 Mar 31 03:04:28 balabala systemd-udevd[242]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 31 03:04:28 balabala kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Mar 31 03:04:28 balabala kernel: videodev: Linux video capture interface: v2.00 Mar 31 03:04:28 balabala kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Mar 31 03:04:28 balabala kernel: [vc_sm_connected_init]: start Mar 31 03:04:28 balabala kernel: [vc_sm_connected_init]: installed successfully Mar 31 03:04:28 balabala kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Mar 31 03:04:28 balabala kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Mar 31 03:04:29 balabala kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 31 03:04:29 balabala kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Mar 31 03:04:29 balabala kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Mar 31 03:04:29 balabala kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Mar 31 03:04:29 balabala kernel: rpivid feb10000.codec: Device registered as /dev/video19 Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Mar 31 03:04:29 balabala kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Mar 31 03:04:29 balabala kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 31 03:04:29 balabala kernel: Bluetooth: Core ver 2.22 Mar 31 03:04:29 balabala kernel: NET: Registered PF_BLUETOOTH protocol family Mar 31 03:04:29 balabala kernel: Bluetooth: HCI device and connection manager initialized Mar 31 03:04:29 balabala kernel: Bluetooth: HCI socket layer initialized Mar 31 03:04:29 balabala kernel: Bluetooth: L2CAP socket layer initialized Mar 31 03:04:29 balabala kernel: Bluetooth: SCO socket layer initialized Mar 31 03:04:29 balabala kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Mar 31 03:04:29 balabala kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 31 03:04:29 balabala kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Mar 31 03:04:29 balabala kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Mar 31 03:04:29 balabala kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Mar 31 03:04:29 balabala kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Mar 31 03:04:29 balabala kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Mar 31 03:04:29 balabala kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 31 03:04:30 balabala kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 31 03:04:30 balabala systemd-udevd[240]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 31 03:04:30 balabala kernel: Bluetooth: HCI UART driver ver 2.3 Mar 31 03:04:30 balabala kernel: Bluetooth: HCI UART protocol H4 registered Mar 31 03:04:30 balabala kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Mar 31 03:04:30 balabala kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Mar 31 03:04:30 balabala kernel: Bluetooth: HCI UART protocol Broadcom registered Mar 31 03:04:30 balabala kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Mar 31 03:04:30 balabala systemd[1]: Found device /dev/mmcblk0p1. Mar 31 03:04:30 balabala kernel: uart-pl011 fe201000.serial: no DMA platform data Mar 31 03:04:30 balabala kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Mar 31 03:04:30 balabala kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Mar 31 03:04:30 balabala kernel: usbcore: registered new interface driver brcmfmac Mar 31 03:04:30 balabala kernel: Bluetooth: hci0: BCM: chip id 107 Mar 31 03:04:30 balabala kernel: Bluetooth: hci0: BCM: features 0x2f Mar 31 03:04:30 balabala kernel: Bluetooth: hci0: BCM4345C0 Mar 31 03:04:30 balabala kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Mar 31 03:04:30 balabala kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Mar 31 03:04:30 balabala kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Mar 31 03:04:30 balabala systemd-udevd[248]: Using default interface naming scheme 'v240'. Mar 31 03:04:30 balabala systemd-udevd[248]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 31 03:04:31 balabala kernel: hwmon hwmon1: Undervoltage detected! Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Mar 31 03:04:31 balabala kernel: Bluetooth: hci0: BCM: features 0x2f Mar 31 03:04:31 balabala kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Mar 31 03:04:31 balabala kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Mar 31 03:04:31 balabala systemd[1]: Created slice system-bthelper.slice. Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in Huge Pages File System being skipped. Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in FUSE Control File System being skipped. Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Mar 31 03:04:31 balabala systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 31 03:04:31 balabala systemd[1]: Starting File System Check on /dev/mmcblk0p1... Mar 31 03:04:31 balabala systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 31 03:04:31 balabala systemd[1]: Started File System Check Daemon to report status. Mar 31 03:04:31 balabala systemd[1]: Started Load/Save RF Kill Switch Status. Mar 31 03:04:31 balabala systemd-fsck[387]: fsck.fat 4.1 (2017-01-24) Mar 31 03:04:31 balabala systemd-fsck[387]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Mar 31 03:04:31 balabala systemd-fsck[387]: Automatically removing dirty bit. Mar 31 03:04:31 balabala systemd-fsck[387]: Performing changes. Mar 31 03:04:31 balabala systemd-fsck[387]: /dev/mmcblk0p1: 367 files, 33349/46774 clusters Mar 31 03:04:31 balabala systemd[1]: Started File System Check on /dev/mmcblk0p1. Mar 31 03:04:31 balabala systemd[1]: Mounting /boot... Mar 31 03:04:31 balabala systemd[1]: Mounted /boot. Mar 31 03:04:31 balabala systemd[1]: Reached target Local File Systems. Mar 31 03:04:31 balabala systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 31 03:04:31 balabala systemd[1]: Starting Raise network interfaces... Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Mar 31 03:04:31 balabala systemd[1]: Starting Preprocess NFS configuration... Mar 31 03:04:31 balabala systemd[1]: Starting Create Volatile Files and Directories... Mar 31 03:04:31 balabala systemd[1]: Started ifup for eth0. Mar 31 03:04:31 balabala systemd[1]: Started ifup for wlan0. Mar 31 03:04:31 balabala systemd[1]: plymouth-read-write.service: Succeeded. Mar 31 03:04:31 balabala systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 31 03:04:31 balabala systemd[1]: Received SIGRTMIN+20 from PID 256 (plymouthd). Mar 31 03:04:31 balabala systemd[1]: nfs-config.service: Succeeded. Mar 31 03:04:31 balabala systemd[1]: Started Preprocess NFS configuration. Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Mar 31 03:04:31 balabala systemd[1]: Reached target NFS client services. Mar 31 03:04:31 balabala systemd[1]: Started Create Volatile Files and Directories. Mar 31 03:04:31 balabala systemd[1]: Starting RPC bind portmap service... Mar 31 03:04:31 balabala systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Mar 31 03:04:31 balabala systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 31 03:04:31 balabala systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 31 03:04:32 balabala kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 31 03:04:32 balabala systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 31 03:04:32 balabala kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 31 03:04:32 balabala systemd[1]: Reached target System Initialization. Mar 31 03:04:32 balabala systemd[1]: apt-daily.timer: Not using persistent file timestamp Wed 2024-04-03 12:38:18 +03 as it is in the future. Mar 31 03:04:32 balabala systemd[1]: Started Daily apt download activities. Mar 31 03:04:32 balabala systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Wed 2024-04-03 06:53:18 +03 as it is in the future. Mar 31 03:04:32 balabala systemd[1]: Started Daily apt upgrade and clean activities. Mar 31 03:04:32 balabala systemd[1]: Started Volumio Splash. Mar 31 03:04:32 balabala systemd[473]: volumiosplash.service: Failed to execute command: No such file or directory Mar 31 03:04:32 balabala systemd[473]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Mar 31 03:04:32 balabala systemd[1]: Listening on triggerhappy.socket. Mar 31 03:04:32 balabala systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 31 03:04:32 balabala systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 31 03:04:32 balabala systemd[1]: Reached target Timers. Mar 31 03:04:32 balabala systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 31 03:04:32 balabala systemd[1]: Reached target Sockets. Mar 31 03:04:32 balabala systemd[1]: Reached target Basic System. Mar 31 03:04:32 balabala systemd[1]: Starting Login Service... Mar 31 03:04:32 balabala systemd[1]: Starting triggerhappy global hotkey daemon... Mar 31 03:04:32 balabala systemd[1]: Started volumio-remote-updater.service. Mar 31 03:04:32 balabala systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Mar 31 03:04:32 balabala systemd[1]: Started Manage Sound Card State (restore and store). Mar 31 03:04:32 balabala alsactl[487]: alsactl 1.1.8 daemon started Mar 31 03:04:32 balabala thd[482]: Unable to parse trigger line: Mar 31 03:04:32 balabala thd[482]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Mar 31 03:04:32 balabala thd[482]: Unable to parse trigger line: Mar 31 03:04:32 balabala thd[482]: Found socket passed from systemd Mar 31 03:04:32 balabala systemd[1]: Started D-Bus System Message Bus. Mar 31 03:04:32 balabala systemd[1]: Starting WPA supplicant... Mar 31 03:04:32 balabala systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Mar 31 03:04:32 balabala systemd[1]: Started Volumio Log Rotation Service. Mar 31 03:04:32 balabala systemd[1]: Started UPnP Renderer front-end to MPD. Mar 31 03:04:32 balabala systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 31 03:04:32 balabala systemd[1]: Starting Configure Bluetooth Modems connected by UART... Mar 31 03:04:32 balabala systemd-logind[480]: New seat seat0. Mar 31 03:04:32 balabala systemd[1]: Starting Wireless Services... Mar 31 03:04:32 balabala systemd[1]: Starting Save/Restore Sound Card State... Mar 31 03:04:32 balabala systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Mar 31 03:04:32 balabala systemd[1]: Starting dhcpcd on all interfaces... Mar 31 03:04:32 balabala systemd[1]: Started Volumio Iptables Module. Mar 31 03:04:32 balabala systemd[1]: Started RPC bind portmap service. Mar 31 03:04:32 balabala systemd[1]: Started triggerhappy global hotkey daemon. Mar 31 03:04:32 balabala systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Mar 31 03:04:32 balabala systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Mar 31 03:04:32 balabala systemd[1]: Reached target Remote File Systems (Pre). Mar 31 03:04:32 balabala systemd[1]: Reached target Remote File Systems. Mar 31 03:04:32 balabala dhcpcd[517]: Not running dhcpcd because /etc/network/interfaces Mar 31 03:04:32 balabala kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Mar 31 03:04:32 balabala kernel: bcmgenet fd580000.ethernet eth0: Link is Down Mar 31 03:04:32 balabala sh[399]: eth0: waiting for carrier Mar 31 03:04:32 balabala dhcpcd[517]: defines some interfaces that will use a Mar 31 03:04:32 balabala dhcpcd[517]: DHCP client or static address Mar 31 03:04:32 balabala dhcpcd[444]: eth0: waiting for carrier Mar 31 03:04:32 balabala systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 31 03:04:32 balabala systemd[1]: Reached target RPC Port Mapper. Mar 31 03:04:32 balabala systemd[1]: Started Save/Restore Sound Card State. Mar 31 03:04:32 balabala systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Mar 31 03:04:32 balabala systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Mar 31 03:04:32 balabala systemd[1]: Failed to start dhcpcd on all interfaces. Mar 31 03:04:32 balabala sh[400]: wlan0=wlan0 Mar 31 03:04:32 balabala avahi-daemon[507]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Mar 31 03:04:32 balabala avahi-daemon[507]: Successfully dropped root privileges. Mar 31 03:04:32 balabala avahi-daemon[507]: avahi-daemon 0.7 starting up. Mar 31 03:04:32 balabala systemd[1]: hciuart.service: Succeeded. Mar 31 03:04:32 balabala systemd[1]: Started Configure Bluetooth Modems connected by UART. Mar 31 03:04:32 balabala systemd[1]: Starting Raspberry Pi bluetooth helper... Mar 31 03:04:32 balabala systemd[1]: Reached target Sound Card. Mar 31 03:04:33 balabala bthelper[553]: Raspberry Pi BDADDR already set Mar 31 03:04:33 balabala kernel: hwmon hwmon1: Voltage normalised Mar 31 03:04:33 balabala systemd[1]: Started Login Service. Mar 31 03:04:33 balabala systemd[1]: Started Raspberry Pi bluetooth helper. Mar 31 03:04:33 balabala avahi-daemon[507]: Successfully called chroot(). Mar 31 03:04:33 balabala avahi-daemon[507]: Successfully dropped remaining capabilities. Mar 31 03:04:33 balabala wpa_supplicant[501]: Successfully initialized wpa_supplicant Mar 31 03:04:33 balabala avahi-daemon[507]: Loading service file /services/volumio.service. Mar 31 03:04:33 balabala avahi-daemon[507]: Network interface enumeration completed. Mar 31 03:04:33 balabala avahi-daemon[507]: Server startup complete. Host name is balabala.local. Local service cookie is 3666089720. Mar 31 03:04:33 balabala avahi-daemon[507]: Service "balabala" (/services/volumio.service) successfully established. Mar 31 03:04:33 balabala systemd[1]: Started Raise network interfaces. Mar 31 03:04:33 balabala systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 31 03:04:33 balabala systemd[1]: Started WPA supplicant. Mar 31 03:04:33 balabala systemd[1]: Reached target Network. Mar 31 03:04:33 balabala systemd[1]: Starting Permit User Sessions... Mar 31 03:04:33 balabala systemd[1]: Starting Network Time Service... Mar 31 03:04:33 balabala systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Mar 31 03:04:33 balabala systemd[1]: Reached target Network is Online. Mar 31 03:04:33 balabala volumio-remote-updater[483]: Error: No active session Mar 31 03:04:33 balabala volumio-remote-updater[483]: [2024-03-31 03:04:33] [info] asio async_connect error: system:111 (Connection refused) Mar 31 03:04:33 balabala systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 31 03:04:33 balabala volumio-remote-updater[483]: [2024-03-31 03:04:33] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 31 03:04:33 balabala volumio-remote-updater[483]: [2024-03-31 03:04:33] [error] handle_connect error: Underlying Transport Error Mar 31 03:04:33 balabala systemd[1]: Starting /etc/rc.local Compatibility... Mar 31 03:04:33 balabala systemd[1]: Starting LSB: Brings up/down network automatically... Mar 31 03:04:33 balabala systemd[1]: Starting Samba NMB Daemon... Mar 31 03:04:33 balabala systemd[1]: Starting Bluetooth service... Mar 31 03:04:33 balabala systemd[1]: Started /etc/rc.local Compatibility. Mar 31 03:04:33 balabala volumio[506]: Could not open config: /tmp/upmpdcli.conf Mar 31 03:04:33 balabala systemd[1]: Started Permit User Sessions. Mar 31 03:04:33 balabala systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 31 03:04:33 balabala systemd[1]: Starting Hold until boot process finishes up... Mar 31 03:04:33 balabala systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 31 03:04:33 balabala systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 31 03:04:33 balabala systemd[1]: plymouth-start.service: Succeeded. Mar 31 03:04:33 balabala systemd[1]: plymouth-quit.service: Succeeded. Mar 31 03:04:33 balabala systemd[1]: Started Terminate Plymouth Boot Screen. Mar 31 03:04:33 balabala systemd[1]: plymouth-quit-wait.service: Succeeded. Mar 31 03:04:33 balabala systemd[1]: Started Hold until boot process finishes up. Mar 31 03:04:33 balabala systemd[1]: Received SIGRTMIN+21 from PID 256 (n/a). Mar 31 03:04:33 balabala systemd[1]: Received SIGRTMIN+21 from PID 256 (n/a). Mar 31 03:04:33 balabala systemd[1]: Started Getty on tty1. Mar 31 03:04:33 balabala systemd[1]: Reached target Login Prompts. Mar 31 03:04:34 balabala loadcpufreq[526]: Loading cpufreq kernel modules...done (none). Mar 31 03:04:34 balabala systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 31 03:04:34 balabala bluetoothd[600]: Bluetooth daemon 5.50 Mar 31 03:04:34 balabala ntpd[589]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 31 03:04:34 balabala ntpd[589]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Mar 31 03:04:34 balabala systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 31 03:04:34 balabala bluetoothd[600]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 31 03:04:34 balabala ifplugd(eth0)[644]: ifplugd 0.28 initializing. Mar 31 03:04:34 balabala ifplugd(eth0)[644]: Using interface eth0/D8:3A:DD:76:C5:7A with driver (version: 6.1.69-v7l+) Mar 31 03:04:34 balabala systemd[1]: Started Network Time Service. Mar 31 03:04:34 balabala ifplugd(eth0)[644]: Using detection mode: SIOCETHTOOL Mar 31 03:04:34 balabala ifplugd(eth0)[644]: Initialization complete, link beat not detected. Mar 31 03:04:34 balabala systemd[1]: Started Bluetooth service. Mar 31 03:04:34 balabala systemd[1]: Reached target Bluetooth. Mar 31 03:04:34 balabala bluetoothd[600]: Starting SDP server Mar 31 03:04:34 balabala bluetoothd[600]: Excluding (cli) sap Mar 31 03:04:34 balabala ntpd[637]: proto: precision = 2.130 usec (-19) Mar 31 03:04:34 balabala ntpd[637]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 31 03:04:34 balabala ntpd[637]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 31 03:04:34 balabala ntpd[637]: Listen and drop on 0 v6wildcard [::]:123 Mar 31 03:04:34 balabala ntpd[637]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 31 03:04:34 balabala ntpd[637]: Listen normally on 2 lo 127.0.0.1:123 Mar 31 03:04:34 balabala ntpd[637]: Listening on routing socket on fd #19 for interface updates Mar 31 03:04:34 balabala ntpd[637]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 31 03:04:34 balabala ntpd[637]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 31 03:04:34 balabala ifplugd[596]: Network Interface Plugging Daemon...start eth0...done. Mar 31 03:04:34 balabala systemd[1]: Started LSB: Brings up/down network automatically. Mar 31 03:04:34 balabala systemd[1]: iptables.service: Succeeded. Mar 31 03:04:34 balabala kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 31 03:04:34 balabala kernel: Bluetooth: BNEP filters: protocol multicast Mar 31 03:04:34 balabala kernel: Bluetooth: BNEP socket layer initialized Mar 31 03:04:34 balabala bluetoothd[600]: Bluetooth management interface 1.22 initialized Mar 31 03:04:34 balabala dbus-daemon[493]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=600 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Mar 31 03:04:34 balabala kernel: Bluetooth: MGMT ver 1.22 Mar 31 03:04:34 balabala cpufrequtils[635]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Mar 31 03:04:34 balabala systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 31 03:04:34 balabala bluetoothd[600]: Failed to set privacy: Rejected (0x0b) Mar 31 03:04:34 balabala systemd[1]: Starting Hostname Service... Mar 31 03:04:34 balabala dbus-daemon[493]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 31 03:04:34 balabala systemd[1]: Started Hostname Service. Mar 31 03:04:34 balabala nmbd[602]: [2024/03/31 03:04:34.903451, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 31 03:04:34 balabala nmbd[602]: started asyncdns process 669 Mar 31 03:04:34 balabala nmbd[602]: [2024/03/31 03:04:34.906223, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 31 03:04:34 balabala nmbd[602]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 31 03:04:34 balabala nmbd[602]: [2024/03/31 03:04:34.907094, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 31 03:04:34 balabala nmbd[602]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 31 03:04:34 balabala haveged[458]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Mar 31 03:04:34 balabala haveged[458]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Mar 31 03:04:34 balabala haveged[458]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.0014 Mar 31 03:04:34 balabala haveged[458]: haveged: fills: 0, generated: 0 Mar 31 03:04:35 balabala ntpd[637]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 31 03:04:35 balabala wireless.js[513]: Cleaning previous... Mar 31 03:04:35 balabala sudo[677]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 31 03:04:35 balabala sudo[677]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:35 balabala sudo[677]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:35 balabala sudo[679]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 31 03:04:35 balabala sudo[679]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:35 balabala kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Mar 31 03:04:35 balabala sh[399]: eth0: carrier acquired Mar 31 03:04:35 balabala dhcpcd[444]: eth0: carrier acquired Mar 31 03:04:35 balabala sudo[679]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:35 balabala sh[399]: DUID 00:01:00:01:2d:5e:64:9e:d8:3a:dd:76:c5:7a Mar 31 03:04:35 balabala sh[399]: eth0: IAID dd:76:c5:7a Mar 31 03:04:35 balabala dhcpcd[444]: DUID 00:01:00:01:2d:5e:64:9e:d8:3a:dd:76:c5:7a Mar 31 03:04:35 balabala dhcpcd[444]: eth0: IAID dd:76:c5:7a Mar 31 03:04:35 balabala sh[399]: eth0: adding address fe80::53fb:d12f:c844:c9ae Mar 31 03:04:35 balabala sh[399]: ipv6_addaddr1: Permission denied Mar 31 03:04:35 balabala dhcpcd[444]: eth0: adding address fe80::53fb:d12f:c844:c9ae Mar 31 03:04:35 balabala dhcpcd[444]: ipv6_addaddr1: Permission denied Mar 31 03:04:35 balabala wireless.js[513]: Stopped aP Mar 31 03:04:35 balabala sudo[687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 31 03:04:35 balabala sudo[687]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:35 balabala sudo[687]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:35 balabala kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 31 03:04:36 balabala sudo[689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 31 03:04:36 balabala sudo[689]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:36 balabala sudo[689]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:36 balabala sh[399]: eth0: rebinding lease of 192.168.1.94 Mar 31 03:04:36 balabala dhcpcd[444]: eth0: rebinding lease of 192.168.1.94 Mar 31 03:04:36 balabala sudo[696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 31 03:04:36 balabala sudo[696]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:36 balabala sudo[696]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:36 balabala sudo[698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 31 03:04:36 balabala sudo[698]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:36 balabala sh[399]: eth0: probing address 192.168.1.94/24 Mar 31 03:04:36 balabala dhcpcd[444]: eth0: probing address 192.168.1.94/24 Mar 31 03:04:36 balabala ntpd[637]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 31 03:04:36 balabala ifplugd(eth0)[644]: Link beat detected. Mar 31 03:04:36 balabala sh[399]: eth0: soliciting an IPv6 router Mar 31 03:04:36 balabala dhcpcd[444]: eth0: soliciting an IPv6 router Mar 31 03:04:36 balabala ifplugd(eth0)[644]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 31 03:04:36 balabala ifplugd(eth0)[644]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Mar 31 03:04:36 balabala systemd[1]: systemd-rfkill.service: Succeeded. Mar 31 03:04:37 balabala ntpd[637]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 31 03:04:38 balabala ntpd[637]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 31 03:04:38 balabala bthelper[553]: Changing power off succeeded Mar 31 03:04:38 balabala bthelper[553]: [CHG] Controller D8:3A:DD:76:C5:7E Powered: no Mar 31 03:04:38 balabala bthelper[553]: [CHG] Controller D8:3A:DD:76:C5:7E Discovering: no Mar 31 03:04:38 balabala bthelper[553]: [CHG] Controller D8:3A:DD:76:C5:7E Class: 0x00000000 Mar 31 03:04:38 balabala bthelper[553]: [CHG] Controller D8:3A:DD:76:C5:7E Class: 0x0000041c Mar 31 03:04:38 balabala bthelper[553]: Changing power on succeeded Mar 31 03:04:38 balabala volumio-remote-updater[483]: [2024-03-31 03:04:38] [info] asio async_connect error: system:111 (Connection refused) Mar 31 03:04:38 balabala volumio-remote-updater[483]: [2024-03-31 03:04:38] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 31 03:04:38 balabala volumio-remote-updater[483]: [2024-03-31 03:04:38] [error] handle_connect error: Underlying Transport Error Mar 31 03:04:38 balabala sudo[698]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:38 balabala wireless.js[513]: SETTING APPROPRIATE REG DOMAIN: GB Mar 31 03:04:38 balabala sudo[714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 31 03:04:38 balabala sudo[714]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:38 balabala sudo[714]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:38 balabala sudo[716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set GB Mar 31 03:04:38 balabala sudo[716]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:38 balabala sudo[716]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:38 balabala wireless.js[513]: SUCCESSFULLY SET NEW REGDOMAIN: GB Mar 31 03:04:38 balabala sudo[723]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 31 03:04:38 balabala sudo[723]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:38 balabala sudo[723]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:38 balabala sudo[725]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 31 03:04:38 balabala sudo[725]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:39 balabala sudo[725]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:39 balabala avahi-daemon[507]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 31 03:04:39 balabala avahi-daemon[507]: New relevant interface wlan0.IPv4 for mDNS. Mar 31 03:04:39 balabala avahi-daemon[507]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Mar 31 03:04:39 balabala kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 31 03:04:39 balabala systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Mar 31 03:04:39 balabala systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Mar 31 03:04:39 balabala dnsmasq[731]: dnsmasq: syntax check OK. Mar 31 03:04:39 balabala hostapd[732]: Configuration file: /etc/hostapd/hostapd.conf Mar 31 03:04:39 balabala hostapd[732]: wlan0: Could not connect to kernel driver Mar 31 03:04:39 balabala hostapd[732]: Using interface wlan0 with hwaddr d8:3a:dd:76:c5:7c and ssid "Volumio-67AE7" Mar 31 03:04:39 balabala dnsmasq[738]: started, version 2.80 cachesize 150 Mar 31 03:04:39 balabala dnsmasq[738]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Mar 31 03:04:39 balabala dnsmasq-dhcp[738]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Mar 31 03:04:39 balabala dnsmasq[738]: reading /etc/resolv.conf Mar 31 03:04:39 balabala dnsmasq[738]: using nameserver 208.67.222.222#53 Mar 31 03:04:39 balabala dnsmasq[738]: using nameserver 208.67.220.220#53 Mar 31 03:04:39 balabala dnsmasq[738]: read /etc/hosts - 1 addresses Mar 31 03:04:39 balabala hostapd[732]: wlan0: interface state UNINITIALIZED->ENABLED Mar 31 03:04:39 balabala hostapd[732]: wlan0: AP-ENABLED Mar 31 03:04:39 balabala systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Mar 31 03:04:39 balabala systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Mar 31 03:04:39 balabala systemd[1]: Reached target Host and Network Name Lookups. Mar 31 03:04:39 balabala iwconfig[746]: Error for wireless request "Set Power Management" (8B2C) : Mar 31 03:04:39 balabala iwconfig[746]: SET failed on device wlan0 ; Invalid argument. Mar 31 03:04:39 balabala systemd[1]: wireless.service: Succeeded. Mar 31 03:04:39 balabala systemd[1]: Started Wireless Services. Mar 31 03:04:39 balabala systemd[1]: Started Volumio Backend Module. Mar 31 03:04:39 balabala systemd[1]: Started Volumio Cpu Tweaker. Mar 31 03:04:39 balabala volumio-cpu-tweak[748]: Setting RT Priority for mpd Mar 31 03:04:39 balabala volumio-cpu-tweak[748]: pid 35's current scheduling policy: SCHED_OTHER Mar 31 03:04:39 balabala volumio-cpu-tweak[748]: pid 35's current scheduling priority: 0 Mar 31 03:04:39 balabala volumio-cpu-tweak[748]: Setting MPD Affinity Mar 31 03:04:39 balabala volumio-cpu-tweak[748]: pid 3's current affinity mask: f Mar 31 03:04:39 balabala nmbd[602]: [2024/03/31 03:04:39.910174, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 31 03:04:39 balabala nmbd[602]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 31 03:04:39 balabala systemd[1]: Started Samba NMB Daemon. Mar 31 03:04:39 balabala systemd[1]: Starting Samba Winbind Daemon... Mar 31 03:04:39 balabala volumio-cpu-tweak[748]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 31 03:04:39 balabala volumio-cpu-tweak[748]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 31 03:04:39 balabala systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 31 03:04:40 balabala winbindd[763]: [2024/03/31 03:04:40.132853, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 31 03:04:40 balabala winbindd[763]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 31 03:04:40 balabala winbindd[763]: [2024/03/31 03:04:40.151444, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 31 03:04:40 balabala winbindd[763]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 31 03:04:40 balabala systemd[1]: Started Samba Winbind Daemon. Mar 31 03:04:40 balabala systemd[1]: Starting Samba SMB Daemon... Mar 31 03:04:40 balabala winbindd[763]: [2024/03/31 03:04:40.553096, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Mar 31 03:04:40 balabala winbindd[763]: res_names->count = 3, expected 4 Mar 31 03:04:40 balabala smbd[769]: [2024/03/31 03:04:40.575231, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 31 03:04:40 balabala smbd[769]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 31 03:04:40 balabala systemd[1]: Started Samba SMB Daemon. Mar 31 03:04:40 balabala systemd[1]: Reached target Multi-User System. Mar 31 03:04:40 balabala systemd[1]: Reached target Graphical Interface. Mar 31 03:04:40 balabala systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 31 03:04:40 balabala systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 31 03:04:40 balabala systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 31 03:04:40 balabala systemd[1]: Startup finished in 9.251s (kernel) + 14.329s (userspace) = 23.581s. Mar 31 03:04:40 balabala sh[399]: eth0: leased 192.168.1.94 for 86400 seconds Mar 31 03:04:40 balabala dhcpcd[444]: eth0: leased 192.168.1.94 for 86400 seconds Mar 31 03:04:40 balabala sh[399]: eth0: adding route to 192.168.1.0/24 Mar 31 03:04:40 balabala sh[399]: eth0: adding default route via 192.168.1.1 Mar 31 03:04:40 balabala dhcpcd[444]: eth0: adding route to 192.168.1.0/24 Mar 31 03:04:40 balabala dhcpcd[444]: eth0: adding default route via 192.168.1.1 Mar 31 03:04:40 balabala avahi-daemon[507]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.94. Mar 31 03:04:40 balabala avahi-daemon[507]: New relevant interface eth0.IPv4 for mDNS. Mar 31 03:04:40 balabala avahi-daemon[507]: Registering new address record for 192.168.1.94 on eth0.IPv4. Mar 31 03:04:40 balabala dnsmasq[738]: reading /etc/resolv.conf Mar 31 03:04:40 balabala dnsmasq[738]: using nameserver 192.168.1.1#53 Mar 31 03:04:40 balabala dnsmasq[738]: using nameserver 208.67.222.222#53 Mar 31 03:04:40 balabala dnsmasq[738]: using nameserver 208.67.220.220#53 Mar 31 03:04:40 balabala sh[399]: forked to background, child pid 798 Mar 31 03:04:40 balabala dhcpcd[444]: forked to background, child pid 798 Mar 31 03:04:41 balabala ifplugd(eth0)[644]: client: ifup: interface eth0 already configured Mar 31 03:04:41 balabala sh[399]: eth0=eth0 Mar 31 03:04:41 balabala ifplugd(eth0)[644]: Program executed successfully. Mar 31 03:04:41 balabala volumio[747]: info: ------------------------------------------- Mar 31 03:04:41 balabala volumio[747]: info: ----- Volumio3 ---- Mar 31 03:04:41 balabala volumio[747]: info: ------------------------------------------- Mar 31 03:04:41 balabala volumio[747]: info: ----- System startup ---- Mar 31 03:04:41 balabala volumio[747]: info: ------------------------------------------- Mar 31 03:04:42 balabala ntpd[637]: Listen normally on 3 eth0 192.168.1.94:123 Mar 31 03:04:42 balabala ntpd[637]: Listen normally on 4 wlan0 192.168.211.1:123 Mar 31 03:04:42 balabala ntpd[637]: new interface(s) found: waking up resolver Mar 31 03:04:42 balabala volumio[747]: info: MYVOLUMIO Environment detected Mar 31 03:04:42 balabala volumio[747]: info: Plugin folders cleanup Mar 31 03:04:42 balabala volumio[747]: info: Scanning into folder /volumio/app/plugins/ Mar 31 03:04:42 balabala volumio[747]: info: Scanning category audio_interface Mar 31 03:04:42 balabala volumio[747]: info: Scanning category miscellanea Mar 31 03:04:42 balabala volumio[747]: info: Scanning category music_service Mar 31 03:04:42 balabala volumio[747]: info: Scanning category plugins.json Mar 31 03:04:42 balabala volumio[747]: info: Scanning category system_controller Mar 31 03:04:42 balabala volumio[747]: info: Scanning category user_interface Mar 31 03:04:42 balabala volumio[747]: info: Scanning into folder /data/plugins/ Mar 31 03:04:42 balabala volumio[747]: info: Scanning category system_controller Mar 31 03:04:42 balabala volumio[747]: info: Plugin folders cleanup completed Mar 31 03:04:42 balabala volumio[747]: info: ------------------------------------------- Mar 31 03:04:42 balabala volumio[747]: info: ----- Core plugins startup ---- Mar 31 03:04:42 balabala volumio[747]: info: ------------------------------------------- Mar 31 03:04:42 balabala volumio[747]: info: Loading plugins from folder /volumio/app/plugins/ Mar 31 03:04:42 balabala volumio[747]: info: Adding plugin upnp to MyMusic Plugins Mar 31 03:04:42 balabala volumio[747]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 31 03:04:42 balabala volumio[747]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 31 03:04:42 balabala volumio[747]: info: Loading plugins from folder /data/plugins/ Mar 31 03:04:42 balabala volumio[747]: info: Loading plugin "system"... Mar 31 03:04:42 balabala volumio[747]: info: Loading plugin "appearance"... Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "network"... Mar 31 03:04:43 balabala volumio[747]: info: Refreshing Cached IP Addresses Mar 31 03:04:43 balabala sudo[838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 31 03:04:43 balabala sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "services"... Mar 31 03:04:43 balabala sudo[840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 31 03:04:43 balabala sudo[838]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:43 balabala sudo[840]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "alsa_controller"... Mar 31 03:04:43 balabala sudo[840]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:43 balabala sudo[843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 31 03:04:43 balabala sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:43 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "wizard"... Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "networkfs"... Mar 31 03:04:43 balabala volumio[747]: info: Starting Udev Watcher for removable devices Mar 31 03:04:43 balabala sudo[849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=balabalamusic,password=XT-NAZMI@MUSIC,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //miniso.synology.me/New Brands Music/BalaBala /mnt/NAS/balabala Mar 31 03:04:43 balabala sudo[849]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:43 balabala volumio[747]: info: Ignoring mount for partition: boot Mar 31 03:04:43 balabala volumio[747]: info: Ignoring mount for partition: volumio Mar 31 03:04:43 balabala volumio[747]: info: Ignoring mount for partition: volumio_data Mar 31 03:04:43 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "volumio_command_line_client"... Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "upnp"... Mar 31 03:04:43 balabala volumio[747]: info: [1711843483701] Starting Upmpd Daemon Mar 31 03:04:43 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "my_music"... Mar 31 03:04:43 balabala volumio[747]: info: Loading plugin "mpd"... Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "upnp_browser"... Mar 31 03:04:44 balabala kernel: Key type cifs.spnego registered Mar 31 03:04:44 balabala kernel: Key type cifs.idmap registered Mar 31 03:04:44 balabala kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Mar 31 03:04:44 balabala kernel: CIFS: Attempting to mount \\miniso.synology.me\New Brands Music Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "alarm-clock"... Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "airplay_emulation"... Mar 31 03:04:44 balabala volumio[747]: info: Starting Shairport Sync Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "last_100"... Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "webradio"... Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "i2s_dacs"... Mar 31 03:04:44 balabala volumio[747]: info: I2S DAC not set, start Auto-detection Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "volumiodiscovery"... Mar 31 03:04:44 balabala volumio[747]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 31 03:04:44 balabala volumio[747]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 31 03:04:44 balabala node[747]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 31 03:04:44 balabala volumio[747]: *** WARNING *** For more information see Mar 31 03:04:44 balabala volumio[747]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 31 03:04:44 balabala volumio[747]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 31 03:04:44 balabala volumio[747]: *** WARNING *** For more information see Mar 31 03:04:44 balabala node[747]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 31 03:04:44 balabala node[747]: *** WARNING *** For more information see Mar 31 03:04:44 balabala node[747]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 31 03:04:44 balabala node[747]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 31 03:04:44 balabala node[747]: *** WARNING *** For more information see Mar 31 03:04:44 balabala volumio[747]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 31 03:04:44 balabala volumio[747]: info: Discovery: Started advertising with name: balabala Mar 31 03:04:44 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "autostart"... Mar 31 03:04:44 balabala volumio[747]: info: Applying required configuration parameters for plugin autostart Mar 31 03:04:44 balabala volumio[747]: info: AutoStart - onVolumioStart - read config.json Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "outputs"... Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "albumart"... Mar 31 03:04:44 balabala volumio[747]: info: Plugin example_plugin is not enabled Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "inputs"... Mar 31 03:04:44 balabala volumio[747]: info: Loading plugin "updater_comm"... Mar 31 03:04:45 balabala volumio[747]: info: Plugin mpdemulation is not enabled Mar 31 03:04:45 balabala volumio[747]: info: Loading plugin "rest_api"... Mar 31 03:04:45 balabala volumio[747]: info: Loading plugin "websocket"... Mar 31 03:04:45 balabala volumio[747]: info: Loading i18n strings for locale en Mar 31 03:04:45 balabala volumio[747]: Updating browse sources language Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 31 03:04:45 balabala volumio[747]: Forking 3 albumart workers Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::initPlayerControls Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 31 03:04:45 balabala volumio[747]: Express server listening on port 3000 Mar 31 03:04:45 balabala volumio[747]: [Metrics] WebUI: 4s 238.30ms Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::resetVolumioState Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::getcurrentVolume Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioRetrievevolume Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 31 03:04:45 balabala volumio[747]: verbose: New Socket.io Connection to 192.168.1.94 from 192.168.1.157 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 1 Mar 31 03:04:45 balabala volumio[747]: verbose: New Socket.io Connection to 192.168.1.94 from 192.168.1.157 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 2 Mar 31 03:04:45 balabala volumio[747]: verbose: New Socket.io Connection to 192.168.1.94 from 192.168.1.157 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 3 Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::pushState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioPushState Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::updateTrackBlock Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrackBlock Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioRetrievevolume Mar 31 03:04:45 balabala volumio[747]: info: Reloading queue from file Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::setRepeat false single undefined Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::pushState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioPushState Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::setRandom false Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::pushState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioPushState Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::pushState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioPushState Mar 31 03:04:45 balabala volumio[747]: info: Setting Device type: Raspberry PI Mar 31 03:04:45 balabala volumio[747]: verbose: New Socket.io Connection to 192.168.1.94 from 192.168.1.157 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 4 Mar 31 03:04:45 balabala volumio[747]: info: Discovery: adding 27998fb4-035c-4ab4-881f-76428ce37fee Mar 31 03:04:45 balabala volumio[747]: info: Discovery: Found device balabala Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: Discovery: this is already registered, 27998fb4-035c-4ab4-881f-76428ce37fee Mar 31 03:04:45 balabala volumio[747]: Starting albumart workers Mar 31 03:04:45 balabala volumio[747]: info: Discovery: Found device balabala Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: Starting albumart workers Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: Received Get System Info Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 03:04:45 balabala volumio[747]: info: Discovery: Getting this device information Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: Starting albumart workers Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetVisibleSources Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetQueue Mar 31 03:04:45 balabala volumio[747]: info: CoreStateMachine::getQueue Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getQueue Mar 31 03:04:45 balabala volumio[747]: info: Listing playlists Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 31 03:04:45 balabala volumio[747]: info: Received Get System Info Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 03:04:45 balabala volumio[747]: info: Discovery: Getting this device information Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 03:04:45 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:45 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:46 balabala volumio-remote-updater[483]: [2024-03-31 03:04:46] [connect] Successful connection Mar 31 03:04:46 balabala volumio-remote-updater[483]: [2024-03-31 03:04:46] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1711843486 101 Mar 31 03:04:46 balabala volumio[747]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5 Mar 31 03:04:46 balabala sudo[849]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:47 balabala sudo[843]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:47 balabala volumio[747]: info: CoreCommandRouter::volumioPlay Mar 31 03:04:47 balabala volumio[747]: info: CoreStateMachine::play index undefined Mar 31 03:04:47 balabala volumio[747]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 03:04:47 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:47 balabala volumio[747]: info: CoreStateMachine::startPlaybackTimer Mar 31 03:04:47 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:47 balabala volumio[747]: verbose: ControllerMpd::clearAddPlayTracks NAS/balabala/9. Tempo (Clean) - Chris Brown.mp3 Mar 31 03:04:47 balabala volumio[747]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 03:04:53 balabala volumio[747]: info: CoreCommandRouter::volumioPlay Mar 31 03:04:53 balabala volumio[747]: info: CoreStateMachine::play index undefined Mar 31 03:04:53 balabala volumio[747]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 03:04:53 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:53 balabala volumio[747]: info: CoreStateMachine::startPlaybackTimer Mar 31 03:04:53 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:53 balabala volumio[747]: verbose: ControllerMpd::clearAddPlayTracks NAS/balabala/9. Tempo (Clean) - Chris Brown.mp3 Mar 31 03:04:53 balabala volumio[747]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 03:04:53 balabala sudo[950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 31 03:04:53 balabala sudo[950]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:53 balabala sudo[950]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:53 balabala sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 31 03:04:53 balabala sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:53 balabala sudo[952]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:53 balabala sudo[956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 31 03:04:53 balabala sudo[956]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:53 balabala systemd[1]: Started UPnP Renderer front-end to MPD. Mar 31 03:04:53 balabala sudo[956]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:53 balabala volumio[747]: info: Upmpdcli Daemon Started Mar 31 03:04:53 balabala volumio[747]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 31 03:04:56 balabala sudo[960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 31 03:04:56 balabala sudo[960]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:56 balabala sudo[960]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:56 balabala sudo[962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 31 03:04:56 balabala sudo[962]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 31 03:04:56 balabala sudo[962]: pam_unix(sudo:session): session closed for user root Mar 31 03:04:56 balabala volumio[747]: verbose: New Socket.io Connection to 192.168.1.94 from 192.168.1.157 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 5 Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::volumioGetVisibleSources Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:56 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 31 03:04:56 balabala volumio[747]: info: Received Get System Info Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 03:04:56 balabala volumio[747]: info: Discovery: Getting this device information Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:56 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:56 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:56 balabala volumio[747]: info: Listing playlists Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 31 03:04:56 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 31 03:04:58 balabala volumio[747]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 31 03:04:58 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:58 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:58 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 31 03:04:58 balabala volumio[747]: info: Received Get System Info Mar 31 03:04:58 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 03:04:58 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 03:04:58 balabala volumio[747]: info: Discovery: Getting this device information Mar 31 03:04:58 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:04:58 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:04:58 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 03:04:59 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 31 03:05:00 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 31 03:05:00 balabala volumio[747]: info: Received Get System Info Mar 31 03:05:00 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 31 03:05:00 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 31 03:05:00 balabala volumio[747]: info: Discovery: Getting this device information Mar 31 03:05:00 balabala volumio[747]: info: CoreCommandRouter::volumioGetState Mar 31 03:05:00 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:05:00 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 31 03:05:00 balabala volumio[747]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 31 03:05:01 balabala systemd[1]: systemd-fsckd.service: Succeeded. Mar 31 03:05:03 balabala volumio[747]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Mar 31 03:05:04 balabala systemd[1]: systemd-hostnamed.service: Succeeded. Mar 31 03:05:05 balabala volumio[747]: info: CoreCommandRouter::volumioPlay Mar 31 03:05:05 balabala volumio[747]: info: CoreStateMachine::play index undefined Mar 31 03:05:05 balabala volumio[747]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 03:05:05 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:05:05 balabala volumio[747]: info: CoreStateMachine::startPlaybackTimer Mar 31 03:05:05 balabala volumio[747]: info: CorePlayQueue::getTrack 0 Mar 31 03:05:05 balabala volumio[747]: verbose: ControllerMpd::clearAddPlayTracks NAS/balabala/9. Tempo (Clean) - Chris Brown.mp3 Mar 31 03:05:05 balabala volumio[747]: verbose: ControllerMpd::sendMpdCommand stop Mar 31 03:05:06 balabala volumio[747]: info: CoreCommandRouter::volumioGetQueue Mar 31 03:05:06 balabala volumio[747]: info: CoreStateMachine::getQueue Mar 31 03:05:06 balabala volumio[747]: info: CorePlayQueue::getQueue Mar 31 03:05:08 balabala volumio[747]: info: Preload queue cleared Mar 31 03:05:08 balabala volumio[747]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 31 03:05:08 balabala volumio[747]: info: CoreStateMachine::ClearQueue Mar 31 03:05:08 balabala volumio[747]: info: CoreStateMachine::stop Mar 31 03:05:08 balabala volumio[747]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 03:05:08 balabala volumio[747]: info: CorePlayQueue::clearPlayQueue Mar 31 03:05:08 balabala volumio[747]: info: CorePlayQueue::saveQueue Mar 31 03:05:08 balabala volumio[747]: info: CoreCommandRouter::volumioPushQueue Mar 31 03:05:08 balabala volumio[747]: info: CoreStateMachine::addQueueItems Mar 31 03:05:08 balabala volumio[747]: info: CorePlayQueue::addQueueItems Mar 31 03:05:08 balabala volumio[747]: info: Preload queue cleared Mar 31 03:05:08 balabala volumio[747]: info: Adding Item to queue: music-library/NAS/balabala/9. Tempo (Clean) - Chris Brown.mp3 Mar 31 03:05:08 balabala volumio[747]: info: Exploding uri music-library/NAS/balabala/9. Tempo (Clean) - Chris Brown.mp3 in service mpd Mar 31 03:05:08 balabala volumio[747]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 03:05:08 balabala volumio[747]: TypeError: Cannot read property 'then' of undefined Mar 31 03:05:08 balabala volumio[747]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Mar 31 03:05:08 balabala volumio[747]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Mar 31 03:05:08 balabala volumio[747]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) Mar 31 03:05:08 balabala volumio[747]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Mar 31 03:05:08 balabala volumio[747]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Mar 31 03:05:08 balabala volumio[747]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Mar 31 03:05:08 balabala volumio[747]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Mar 31 03:05:08 balabala volumio[747]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:501:23) Mar 31 03:05:08 balabala volumio[747]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) Mar 31 03:05:08 balabala volumio[747]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) Mar 31 03:05:08 balabala volumio[747]: at Socket.emit (events.js:315:20) Mar 31 03:05:08 balabala volumio[747]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 31 03:05:08 balabala volumio[747]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 31 03:05:08 balabala volumio[747]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 03:05:09 balabala sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-31 03:04 Mar 31 03:05:09 balabala sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"