-- Logs begin at Fri 2025-06-20 08:47:09 JST, end at Fri 2025-06-20 08:48:30 JST. -- 6月 20 08:47:09 volumior5 kernel: Booting Linux on physical CPU 0x0000000000 [0x414fd0b1] 6月 20 08:47:09 volumior5 kernel: Linux version 6.6.62-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #1816 SMP PREEMPT Mon Nov 18 15:35:52 GMT 2024 6月 20 08:47:09 volumior5 kernel: KASLR enabled 6月 20 08:47:09 volumior5 kernel: random: crng init done 6月 20 08:47:09 volumior5 kernel: Machine model: Raspberry Pi 5 Model B Rev 1.0 6月 20 08:47:09 volumior5 kernel: efi: UEFI not found. 6月 20 08:47:09 volumior5 kernel: Reserved memory: created CMA memory pool at 0x0000000001c00000, size 64 MiB 6月 20 08:47:09 volumior5 kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool 6月 20 08:47:09 volumior5 kernel: OF: reserved mem: 0x0000000001c00000..0x0000000005bfffff (65536 KiB) map reusable linux,cma 6月 20 08:47:09 volumior5 kernel: OF: reserved mem: 0x0000000000000000..0x000000000007ffff (512 KiB) nomap non-reusable atf@0 6月 20 08:47:09 volumior5 kernel: OF: reserved mem: 0x000000003fd16200..0x000000003fd16237 (0 KiB) nomap non-reusable nvram@0 6月 20 08:47:09 volumior5 kernel: NUMA: No NUMA configuration found 6月 20 08:47:09 volumior5 kernel: NUMA: Faking a node at [mem 0x0000000000000000-0x000000007fffffff] 6月 20 08:47:09 volumior5 kernel: NUMA: NODE_DATA [mem 0x7fb9b3c0-0x7fb9dfff] 6月 20 08:47:09 volumior5 kernel: Zone ranges: 6月 20 08:47:09 volumior5 kernel: DMA [mem 0x0000000000000000-0x000000007fffffff] 6月 20 08:47:09 volumior5 kernel: DMA32 empty 6月 20 08:47:09 volumior5 kernel: Normal empty 6月 20 08:47:09 volumior5 kernel: Movable zone start for each node 6月 20 08:47:09 volumior5 kernel: Early memory node ranges 6月 20 08:47:09 volumior5 kernel: node 0: [mem 0x0000000000000000-0x000000000007ffff] 6月 20 08:47:09 volumior5 kernel: node 0: [mem 0x0000000000080000-0x000000003fbfffff] 6月 20 08:47:09 volumior5 kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff] 6月 20 08:47:09 volumior5 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff] 6月 20 08:47:09 volumior5 kernel: On node 0, zone DMA: 1024 pages in unavailable ranges 6月 20 08:47:09 volumior5 kernel: psci: probing for conduit method from DT. 6月 20 08:47:09 volumior5 kernel: psci: PSCIv1.1 detected in firmware. 6月 20 08:47:09 volumior5 kernel: psci: Using standard PSCI v0.2 function IDs 6月 20 08:47:09 volumior5 kernel: psci: MIGRATE_INFO_TYPE not supported. 6月 20 08:47:09 volumior5 kernel: psci: SMC Calling Convention v1.2 6月 20 08:47:09 volumior5 kernel: percpu: Embedded 30 pages/cpu s85928 r8192 d28760 u122880 6月 20 08:47:09 volumior5 kernel: pcpu-alloc: s85928 r8192 d28760 u122880 alloc=30*4096 6月 20 08:47:09 volumior5 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 6月 20 08:47:09 volumior5 kernel: Detected PIPT I-cache on CPU0 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Virtualization Host Extensions 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Hardware dirty bit management 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Spectre-v4 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Spectre-BHB 6月 20 08:47:09 volumior5 kernel: CPU features: kernel page table isolation forced ON by KASLR 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Kernel page table isolation (KPTI) 6月 20 08:47:09 volumior5 kernel: CPU features: detected: SSBS not fully self-synchronizing 6月 20 08:47:09 volumior5 kernel: alternatives: applying boot alternatives 6月 20 08:47:09 volumior5 kernel: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave smsc95xx.macaddr=2C:CF:67:76:58:28 vc_mem.mem_base=0x3fc00000 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=ttyAMA10,115200 console=tty1 imgpart=UUID=7dd89884-34c6-4f67-9803-bf297d9c5536 imgfile=/volumio_current.sqsh bootpart=UUID=4F45-7250 datapart=UUID=48c13753-50c0-4277-abbb-34aba99569f4 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 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 nodebug use_kmsg=no 6月 20 08:47:09 volumior5 kernel: cgroup: Disabling memory control group subsystem 6月 20 08:47:09 volumior5 kernel: mempolicy: NUMA default policy overridden to 'interleave:0' 6月 20 08:47:09 volumior5 kernel: PCIe ASPM is disabled 6月 20 08:47:09 volumior5 kernel: Unknown kernel command line parameters "splash nodebug imgpart=UUID=7dd89884-34c6-4f67-9803-bf297d9c5536 imgfile=/volumio_current.sqsh bootpart=UUID=4F45-7250 datapart=UUID=48c13753-50c0-4277-abbb-34aba99569f4 uuidconfig=cmdline.txt bootdelay=7 use_kmsg=no", will be passed to user space. 6月 20 08:47:09 volumior5 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 6月 20 08:47:09 volumior5 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) 6月 20 08:47:09 volumior5 kernel: Fallback order for Node 0: 0 6月 20 08:47:09 volumior5 kernel: Built 1 zonelists, mobility grouping on. Total pages: 515072 6月 20 08:47:09 volumior5 kernel: Policy zone: DMA 6月 20 08:47:09 volumior5 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off 6月 20 08:47:09 volumior5 kernel: Memory: 1931968K/2093056K available (13440K kernel code, 2208K rwdata, 4284K rodata, 4864K init, 1086K bss, 95552K reserved, 65536K cma-reserved) 6月 20 08:47:09 volumior5 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 6月 20 08:47:09 volumior5 kernel: ftrace: allocating 43555 entries in 171 pages 6月 20 08:47:09 volumior5 kernel: ftrace: allocated 171 pages with 5 groups 6月 20 08:47:09 volumior5 kernel: trace event string verifier disabled 6月 20 08:47:09 volumior5 kernel: rcu: Preemptible hierarchical RCU implementation. 6月 20 08:47:09 volumior5 kernel: rcu: RCU event tracing is enabled. 6月 20 08:47:09 volumior5 kernel: rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. 6月 20 08:47:09 volumior5 kernel: Trampoline variant of Tasks RCU enabled. 6月 20 08:47:09 volumior5 kernel: Rude variant of Tasks RCU enabled. 6月 20 08:47:09 volumior5 kernel: Tracing variant of Tasks RCU enabled. 6月 20 08:47:09 volumior5 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. 6月 20 08:47:09 volumior5 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 6月 20 08:47:09 volumior5 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 6月 20 08:47:09 volumior5 kernel: Root IRQ handler: gic_handle_irq 6月 20 08:47:09 volumior5 kernel: GIC: Using split EOI/Deactivate mode 6月 20 08:47:09 volumior5 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. 6月 20 08:47:09 volumior5 kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). 6月 20 08:47:09 volumior5 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns 6月 20 08:47:09 volumior5 kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns 6月 20 08:47:09 volumior5 kernel: Console: colour dummy device 80x25 6月 20 08:47:09 volumior5 kernel: printk: console [tty1] enabled 6月 20 08:47:09 volumior5 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) 6月 20 08:47:09 volumior5 kernel: pid_max: default: 32768 minimum: 301 6月 20 08:47:09 volumior5 kernel: LSM: initializing lsm=capability,integrity 6月 20 08:47:09 volumior5 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) 6月 20 08:47:09 volumior5 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) 6月 20 08:47:09 volumior5 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. 6月 20 08:47:09 volumior5 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. 6月 20 08:47:09 volumior5 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. 6月 20 08:47:09 volumior5 kernel: rcu: Hierarchical SRCU implementation. 6月 20 08:47:09 volumior5 kernel: rcu: Max phase no-delay instances is 1000. 6月 20 08:47:09 volumior5 kernel: EFI services will not be available. 6月 20 08:47:09 volumior5 kernel: smp: Bringing up secondary CPUs ... 6月 20 08:47:09 volumior5 kernel: Detected PIPT I-cache on CPU1 6月 20 08:47:09 volumior5 kernel: CPU1: Booted secondary processor 0x0000000100 [0x414fd0b1] 6月 20 08:47:09 volumior5 kernel: Detected PIPT I-cache on CPU2 6月 20 08:47:09 volumior5 kernel: CPU2: Booted secondary processor 0x0000000200 [0x414fd0b1] 6月 20 08:47:09 volumior5 kernel: Detected PIPT I-cache on CPU3 6月 20 08:47:09 volumior5 kernel: CPU3: Booted secondary processor 0x0000000300 [0x414fd0b1] 6月 20 08:47:09 volumior5 kernel: smp: Brought up 1 node, 4 CPUs 6月 20 08:47:09 volumior5 kernel: SMP: Total of 4 processors activated. 6月 20 08:47:09 volumior5 kernel: CPU features: detected: 32-bit EL0 Support 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Common not Private translations 6月 20 08:47:09 volumior5 kernel: CPU features: detected: CRC32 instructions 6月 20 08:47:09 volumior5 kernel: CPU features: detected: RCpc load-acquire (LDAPR) 6月 20 08:47:09 volumior5 kernel: CPU features: detected: LSE atomic instructions 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Privileged Access Never 6月 20 08:47:09 volumior5 kernel: CPU features: detected: RAS Extension Support 6月 20 08:47:09 volumior5 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) 6月 20 08:47:09 volumior5 kernel: CPU: All CPU(s) started at EL2 6月 20 08:47:09 volumior5 kernel: alternatives: applying system-wide alternatives 6月 20 08:47:09 volumior5 kernel: devtmpfs: initialized 6月 20 08:47:09 volumior5 kernel: Enabled cp15_barrier support 6月 20 08:47:09 volumior5 kernel: Enabled setend support 6月 20 08:47:09 volumior5 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns 6月 20 08:47:09 volumior5 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) 6月 20 08:47:09 volumior5 kernel: pinctrl core: initialized pinctrl subsystem 6月 20 08:47:09 volumior5 kernel: DMI not present or invalid. 6月 20 08:47:09 volumior5 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family 6月 20 08:47:09 volumior5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations 6月 20 08:47:09 volumior5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations 6月 20 08:47:09 volumior5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations 6月 20 08:47:09 volumior5 kernel: audit: initializing netlink subsys (disabled) 6月 20 08:47:09 volumior5 kernel: audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1 6月 20 08:47:09 volumior5 kernel: thermal_sys: Registered thermal governor 'step_wise' 6月 20 08:47:09 volumior5 kernel: cpuidle: using governor menu 6月 20 08:47:09 volumior5 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. 6月 20 08:47:09 volumior5 kernel: ASID allocator initialised with 32768 entries 6月 20 08:47:09 volumior5 kernel: Serial: AMBA PL011 UART driver 6月 20 08:47:09 volumior5 kernel: bcm2835-mbox 107c013880.mailbox: mailbox enabled 6月 20 08:47:09 volumior5 kernel: 107d001000.serial: ttyAMA10 at MMIO 0x107d001000 (irq = 15, base_baud = 0) is a PL011 rev2 6月 20 08:47:09 volumior5 kernel: printk: console [ttyAMA10] enabled 6月 20 08:47:09 volumior5 kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2024-06-05T15:41:49, variant start_cd 6月 20 08:47:09 volumior5 kernel: raspberrypi-firmware soc:firmware: Firmware hash is 6fe0b09100000000000000000000000000000000 6月 20 08:47:09 volumior5 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL 6月 20 08:47:09 volumior5 kernel: Modules: 0 pages in range for non-PLT usage 6月 20 08:47:09 volumior5 kernel: Modules: 517776 pages in range for PLT usage 6月 20 08:47:09 volumior5 kernel: bcm2835-dma 1000010000.dma: DMA legacy API manager, dmachans=0x1 6月 20 08:47:09 volumior5 kernel: iommu: Default domain type: Translated 6月 20 08:47:09 volumior5 kernel: iommu: DMA domain TLB invalidation policy: strict mode 6月 20 08:47:09 volumior5 kernel: SCSI subsystem initialized 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver usbfs 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver hub 6月 20 08:47:09 volumior5 kernel: usbcore: registered new device driver usb 6月 20 08:47:09 volumior5 kernel: pps_core: LinuxPPS API ver. 1 registered 6月 20 08:47:09 volumior5 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 6月 20 08:47:09 volumior5 kernel: PTP clock support registered 6月 20 08:47:09 volumior5 kernel: vgaarb: loaded 6月 20 08:47:09 volumior5 kernel: clocksource: Switched to clocksource arch_sys_counter 6月 20 08:47:09 volumior5 kernel: VFS: Disk quotas dquot_6.6.0 6月 20 08:47:09 volumior5 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 6月 20 08:47:09 volumior5 kernel: FS-Cache: Loaded 6月 20 08:47:09 volumior5 kernel: CacheFiles: Loaded 6月 20 08:47:09 volumior5 kernel: NET: Registered PF_INET protocol family 6月 20 08:47:09 volumior5 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) 6月 20 08:47:09 volumior5 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) 6月 20 08:47:09 volumior5 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 6月 20 08:47:09 volumior5 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) 6月 20 08:47:09 volumior5 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) 6月 20 08:47:09 volumior5 kernel: TCP: Hash tables configured (established 16384 bind 16384) 6月 20 08:47:09 volumior5 kernel: MPTCP token hash table entries: 2048 (order: 3, 49152 bytes, linear) 6月 20 08:47:09 volumior5 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) 6月 20 08:47:09 volumior5 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) 6月 20 08:47:09 volumior5 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family 6月 20 08:47:09 volumior5 kernel: RPC: Registered named UNIX socket transport module. 6月 20 08:47:09 volumior5 kernel: RPC: Registered udp transport module. 6月 20 08:47:09 volumior5 kernel: RPC: Registered tcp transport module. 6月 20 08:47:09 volumior5 kernel: RPC: Registered tcp-with-tls transport module. 6月 20 08:47:09 volumior5 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. 6月 20 08:47:09 volumior5 kernel: PCI: CLS 0 bytes, default 64 6月 20 08:47:09 volumior5 kernel: Trying to unpack rootfs image as initramfs... 6月 20 08:47:09 volumior5 kernel: kvm [1]: IPA Size Limit: 40 bits 6月 20 08:47:09 volumior5 kernel: kvm [1]: vgic interrupt IRQ9 6月 20 08:47:09 volumior5 kernel: kvm [1]: VHE mode initialized successfully 6月 20 08:47:09 volumior5 kernel: Initialise system trusted keyrings 6月 20 08:47:09 volumior5 kernel: workingset: timestamp_bits=42 max_order=19 bucket_order=0 6月 20 08:47:09 volumior5 kernel: zbud: loaded 6月 20 08:47:09 volumior5 kernel: NFS: Registering the id_resolver key type 6月 20 08:47:09 volumior5 kernel: Key type id_resolver registered 6月 20 08:47:09 volumior5 kernel: Key type id_legacy registered 6月 20 08:47:09 volumior5 kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... 6月 20 08:47:09 volumior5 kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... 6月 20 08:47:09 volumior5 kernel: Key type asymmetric registered 6月 20 08:47:09 volumior5 kernel: Asymmetric key parser 'x509' registered 6月 20 08:47:09 volumior5 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) 6月 20 08:47:09 volumior5 kernel: io scheduler mq-deadline registered 6月 20 08:47:09 volumior5 kernel: io scheduler kyber registered 6月 20 08:47:09 volumior5 kernel: io scheduler bfq registered 6月 20 08:47:09 volumior5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7c502000, parent irq: 26) 6月 20 08:47:09 volumior5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d503000, parent irq: 27) 6月 20 08:47:09 volumior5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d508380, parent irq: 28) 6月 20 08:47:09 volumior5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d508400, parent irq: 29) 6月 20 08:47:09 volumior5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7d510600, parent irq: 30) 6月 20 08:47:09 volumior5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d517b00, parent irq: 31) 6月 20 08:47:09 volumior5 kernel: Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled 6月 20 08:47:09 volumior5 kernel: 107d50c000.serial: ttyS0 at MMIO 0x107d50c000 (irq = 33, base_baud = 6000000) is a Broadcom BCM7271 UART 6月 20 08:47:09 volumior5 kernel: serial serial0: tty port ttyS0 registered 6月 20 08:47:09 volumior5 kernel: iproc-rng200 107d208000.rng: hwrng registered 6月 20 08:47:09 volumior5 kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3fc00000 mem_size:0x40000000(1024 MiB) 6月 20 08:47:09 volumior5 kernel: bcm2712-iommu-cache 1000005b00.iommuc: bcm2712_iommu_cache_probe 6月 20 08:47:09 volumior5 kernel: Freeing initrd memory: 28084K 6月 20 08:47:09 volumior5 kernel: brd: module loaded 6月 20 08:47:09 volumior5 kernel: loop: module loaded 6月 20 08:47:09 volumior5 kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver 6月 20 08:47:09 volumior5 kernel: Loading iSCSI transport class v2.0-870. 6月 20 08:47:09 volumior5 kernel: usbcore: registered new device driver r8152-cfgselector 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver r8152 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver lan78xx 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver smsc95xx 6月 20 08:47:09 volumior5 kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) 6月 20 08:47:09 volumior5 kernel: dwc_otg: FIQ enabled 6月 20 08:47:09 volumior5 kernel: dwc_otg: NAK holdoff enabled 6月 20 08:47:09 volumior5 kernel: dwc_otg: FIQ split-transaction FSM enabled 6月 20 08:47:09 volumior5 kernel: Module dwc_common_port init 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver uas 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver usb-storage 6月 20 08:47:09 volumior5 kernel: mousedev: PS/2 mouse device common for all mice 6月 20 08:47:09 volumior5 kernel: rpi-rtc soc:rpi_rtc: registered as rtc0 6月 20 08:47:09 volumior5 kernel: rpi-rtc soc:rpi_rtc: setting system clock to 2025-06-19T23:46:57 UTC (1750376817) 6月 20 08:47:09 volumior5 kernel: bcm2835-wdt bcm2835-wdt: Poweroff handler already present! 6月 20 08:47:09 volumior5 kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer 6月 20 08:47:09 volumior5 kernel: sdhci: Secure Digital Host Controller Interface driver 6月 20 08:47:09 volumior5 kernel: sdhci: Copyright(c) Pierre Ossman 6月 20 08:47:09 volumior5 kernel: sdhci-pltfm: SDHCI platform and OF driver helper 6月 20 08:47:09 volumior5 kernel: ledtrig-cpu: registered to indicate activity on CPUs 6月 20 08:47:09 volumior5 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... 6月 20 08:47:09 volumior5 kernel: hid: raw HID events driver (C) Jiri Kosina 6月 20 08:47:09 volumior5 kernel: usbcore: registered new interface driver usbhid 6月 20 08:47:09 volumior5 kernel: usbhid: USB HID core driver 6月 20 08:47:09 volumior5 kernel: hw perfevents: enabled with armv8_cortex_a76 PMU driver, 7 counters available 6月 20 08:47:09 volumior5 kernel: NET: Registered PF_PACKET protocol family 6月 20 08:47:09 volumior5 kernel: Key type dns_resolver registered 6月 20 08:47:09 volumior5 kernel: registered taskstats version 1 6月 20 08:47:09 volumior5 kernel: Loading compiled-in X.509 certificates 6月 20 08:47:09 volumior5 kernel: Key type .fscrypt registered 6月 20 08:47:09 volumior5 kernel: Key type fscrypt-provisioning registered 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: host bridge /axi/pcie@110000 ranges: 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: No bus range found for /axi/pcie@110000, using [bus 00-ff] 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: MEM 0x1b80000000..0x1bffffffff -> 0x0080000000 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: MEM 0x1800000000..0x1b7fffffff -> 0x0400000000 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: Forcing gen 2 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: PCI host bridge to bus 0000:00 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:00: root bus resource [mem 0x1b80000000-0x1bffffffff] (bus address [0x80000000-0xffffffff]) 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:00: root bus resource [mem 0x1800000000-0x1b7fffffff pref] (bus address [0x400000000-0x77fffffff]) 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: [14e4:2712] type 01 class 0x060400 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: PME# supported from D0 D3hot 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000110000.pcie: link down 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: PCI bridge to [bus 01] 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: Max Payload Size set to 512/ 512 (was 128), Max Read Rq 512 6月 20 08:47:09 volumior5 kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 38 6月 20 08:47:09 volumior5 kernel: pcieport 0000:00:00.0: AER: enabled with IRQ 38 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:01: busn_res: [bus 01] is released 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:00: busn_res: [bus 00-ff] is released 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: host bridge /axi/pcie@120000 ranges: 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: No bus range found for /axi/pcie@120000, using [bus 00-ff] 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: MEM 0x1f00000000..0x1ffffffffb -> 0x0000000000 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: MEM 0x1c00000000..0x1effffffff -> 0x0400000000 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: IB MEM 0x1f00000000..0x1f003fffff -> 0x0000000000 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: Forcing gen 2 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: PCI host bridge to bus 0000:00 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:00: root bus resource [mem 0x1f00000000-0x1ffffffffb] (bus address [0x00000000-0xfffffffb]) 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:00: root bus resource [mem 0x1c00000000-0x1effffffff pref] (bus address [0x400000000-0x6ffffffff]) 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: [14e4:2712] type 01 class 0x060400 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: PME# supported from D0 D3hot 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring 6月 20 08:47:09 volumior5 kernel: brcm-pcie 1000120000.pcie: link up, 5.0 GT/s PCIe x4 (!SSC) 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: [1de4:0001] type 00 class 0x020000 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: reg 0x10: [mem 0xffffc000-0xffffffff] 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: reg 0x14: [mem 0xffc00000-0xffffffff] 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: reg 0x18: [mem 0xffff0000-0xffffffff] 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: supports D1 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: PME# supported from D0 D1 D3hot D3cold 6月 20 08:47:09 volumior5 kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x1f00000000-0x1f005fffff] 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: BAR 1: assigned [mem 0x1f00000000-0x1f003fffff] 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: BAR 2: assigned [mem 0x1f00400000-0x1f0040ffff] 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x1f00410000-0x1f00413fff] 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: PCI bridge to [bus 01] 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: bridge window [mem 0x1f00000000-0x1f005fffff] 6月 20 08:47:09 volumior5 kernel: pci 0000:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 6月 20 08:47:09 volumior5 kernel: pci 0000:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 6月 20 08:47:09 volumior5 kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) 6月 20 08:47:09 volumior5 kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 39 6月 20 08:47:09 volumior5 kernel: pcieport 0000:00:00.0: AER: enabled with IRQ 39 6月 20 08:47:09 volumior5 kernel: rp1 0000:01:00.0: bar0 len 0x4000, start 0x1f00410000, end 0x1f00413fff, flags, 0x40200 6月 20 08:47:09 volumior5 kernel: rp1 0000:01:00.0: bar1 len 0x400000, start 0x1f00000000, end 0x1f003fffff, flags, 0x40200 6月 20 08:47:09 volumior5 kernel: rp1 0000:01:00.0: enabling device (0000 -> 0002) 6月 20 08:47:09 volumior5 kernel: rp1 0000:01:00.0: chip_id 0x20001927 6月 20 08:47:09 volumior5 kernel: genirq: irq_chip rp1_irq_chip did not update eff. affinity mask of irq 101 6月 20 08:47:09 volumior5 kernel: macb 1f00100000.ethernet eth0: Cadence GEM rev 0x00070109 at 0x1f00100000 irq 107 (2c:cf:67:76:58:28) 6月 20 08:47:09 volumior5 kernel: dw_axi_dmac_platform 1f00188000.dma: DesignWare AXI DMA Controller, 8 channels 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 1 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.0: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000008000000810 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.0: irq 132, io mem 0x1f00200000 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 2 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.0: Host supports USB 3.0 SuperSpeed 6月 20 08:47:09 volumior5 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 6月 20 08:47:09 volumior5 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 6月 20 08:47:09 volumior5 kernel: usb usb1: Product: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: usb usb1: Manufacturer: Linux 6.6.62-v8+ xhci-hcd 6月 20 08:47:09 volumior5 kernel: usb usb1: SerialNumber: xhci-hcd.0 6月 20 08:47:09 volumior5 kernel: hub 1-0:1.0: USB hub found 6月 20 08:47:09 volumior5 kernel: hub 1-0:1.0: 2 ports detected 6月 20 08:47:09 volumior5 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 6月 20 08:47:09 volumior5 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 6月 20 08:47:09 volumior5 kernel: usb usb2: Product: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: usb usb2: Manufacturer: Linux 6.6.62-v8+ xhci-hcd 6月 20 08:47:09 volumior5 kernel: usb usb2: SerialNumber: xhci-hcd.0 6月 20 08:47:09 volumior5 kernel: hub 2-0:1.0: USB hub found 6月 20 08:47:09 volumior5 kernel: hub 2-0:1.0: 1 port detected 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 3 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.1: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000008000000810 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.1: irq 137, io mem 0x1f00300000 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 4 6月 20 08:47:09 volumior5 kernel: xhci-hcd xhci-hcd.1: Host supports USB 3.0 SuperSpeed 6月 20 08:47:09 volumior5 kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 6月 20 08:47:09 volumior5 kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 6月 20 08:47:09 volumior5 kernel: usb usb3: Product: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: usb usb3: Manufacturer: Linux 6.6.62-v8+ xhci-hcd 6月 20 08:47:09 volumior5 kernel: usb usb3: SerialNumber: xhci-hcd.1 6月 20 08:47:09 volumior5 kernel: hub 3-0:1.0: USB hub found 6月 20 08:47:09 volumior5 kernel: hub 3-0:1.0: 2 ports detected 6月 20 08:47:09 volumior5 kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 6月 20 08:47:09 volumior5 kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 6月 20 08:47:09 volumior5 kernel: usb usb4: Product: xHCI Host Controller 6月 20 08:47:09 volumior5 kernel: usb usb4: Manufacturer: Linux 6.6.62-v8+ xhci-hcd 6月 20 08:47:09 volumior5 kernel: usb usb4: SerialNumber: xhci-hcd.1 6月 20 08:47:09 volumior5 kernel: hub 4-0:1.0: USB hub found 6月 20 08:47:09 volumior5 kernel: hub 4-0:1.0: 1 port detected 6月 20 08:47:09 volumior5 kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 6月 20 08:47:09 volumior5 kernel: platform 1000800000.codec: bcm2712_iommu_probe_device: MMU 1000005100.iommu 6月 20 08:47:09 volumior5 kernel: platform 1000800000.codec: bcm2712_iommu_device_group: MMU 1000005100.iommu 6月 20 08:47:09 volumior5 kernel: platform 1000800000.codec: Adding to iommu group 0 6月 20 08:47:09 volumior5 kernel: platform 1000880000.pisp_be: bcm2712_iommu_probe_device: MMU 1000005100.iommu 6月 20 08:47:09 volumior5 kernel: platform 1000880000.pisp_be: bcm2712_iommu_device_group: MMU 1000005100.iommu 6月 20 08:47:09 volumior5 kernel: platform 1000880000.pisp_be: Adding to iommu group 0 6月 20 08:47:09 volumior5 kernel: platform 1000800000.codec: bcm2712_iommu_attach_dev: MMU 1000005100.iommu 6月 20 08:47:09 volumior5 kernel: platform 1000880000.pisp_be: bcm2712_iommu_attach_dev: MMU 1000005100.iommu 6月 20 08:47:09 volumior5 kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_probe: Success 6月 20 08:47:09 volumior5 kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 6月 20 08:47:09 volumior5 kernel: platform axi:gpu: bcm2712_iommu_probe_device: MMU 1000005200.iommu 6月 20 08:47:09 volumior5 kernel: platform axi:gpu: bcm2712_iommu_device_group: MMU 1000005200.iommu 6月 20 08:47:09 volumior5 kernel: platform axi:gpu: Adding to iommu group 1 6月 20 08:47:09 volumior5 kernel: platform axi:gpu: bcm2712_iommu_attach_dev: MMU 1000005200.iommu 6月 20 08:47:09 volumior5 kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_probe: Success 6月 20 08:47:09 volumior5 kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 6月 20 08:47:09 volumior5 kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_probe: Success 6月 20 08:47:09 volumior5 kernel: sdhci-brcmstb 1000fff000.mmc: Got CD GPIO 6月 20 08:47:09 volumior5 kernel: mmc0: CQHCI version 5.10 6月 20 08:47:09 volumior5 kernel: of_cfs_init 6月 20 08:47:09 volumior5 kernel: of_cfs_init: OK 6月 20 08:47:09 volumior5 kernel: clk: Disabling unused clocks 6月 20 08:47:09 volumior5 kernel: mmc1: CQHCI version 5.10 6月 20 08:47:09 volumior5 kernel: mmc0: SDHCI controller on 1000fff000.mmc [1000fff000.mmc] using ADMA 64-bit 6月 20 08:47:09 volumior5 kernel: mmc0: new ultra high speed DDR50 SDHC card at address e624 6月 20 08:47:09 volumior5 kernel: mmcblk0: mmc0:e624 SU08G 7.40 GiB 6月 20 08:47:09 volumior5 kernel: mmcblk0: p1 p2 p3 6月 20 08:47:09 volumior5 kernel: mmcblk0: mmc0:e624 SU08G 7.40 GiB (quirks 0x00004000) 6月 20 08:47:09 volumior5 kernel: mmc1: SDHCI controller on 1001100000.mmc [1001100000.mmc] using ADMA 64-bit 6月 20 08:47:09 volumior5 kernel: Freeing unused kernel memory: 4864K 6月 20 08:47:09 volumior5 kernel: Run /init as init process 6月 20 08:47:09 volumior5 kernel: with arguments: 6月 20 08:47:09 volumior5 kernel: /init 6月 20 08:47:09 volumior5 kernel: splash 6月 20 08:47:09 volumior5 kernel: nodebug 6月 20 08:47:09 volumior5 kernel: with environment: 6月 20 08:47:09 volumior5 kernel: HOME=/ 6月 20 08:47:09 volumior5 kernel: TERM=linux 6月 20 08:47:09 volumior5 kernel: imgpart=UUID=7dd89884-34c6-4f67-9803-bf297d9c5536 6月 20 08:47:09 volumior5 kernel: imgfile=/volumio_current.sqsh 6月 20 08:47:09 volumior5 kernel: bootpart=UUID=4F45-7250 6月 20 08:47:09 volumior5 kernel: datapart=UUID=48c13753-50c0-4277-abbb-34aba99569f4 6月 20 08:47:09 volumior5 kernel: uuidconfig=cmdline.txt 6月 20 08:47:09 volumior5 kernel: bootdelay=7 6月 20 08:47:09 volumior5 kernel: use_kmsg=no 6月 20 08:47:09 volumior5 kernel: mmc1: new ultra high speed DDR50 SDIO card at address 0001 6月 20 08:47:09 volumior5 kernel: usb 1-1: new high-speed USB device number 2 using xhci-hcd 6月 20 08:47:09 volumior5 kernel: usb 1-1: New USB device found, idVendor=0944, idProduct=0208, bcdDevice= 1.00 6月 20 08:47:09 volumior5 kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 6月 20 08:47:09 volumior5 kernel: usb 1-1: Product: DS-DAC-10R 6月 20 08:47:09 volumior5 kernel: usb 1-1: Manufacturer: KORG INC. 6月 20 08:47:09 volumior5 kernel: hid-generic 0003:0944:0208.0001: hiddev96,hidraw0: USB HID v1.10 Device [KORG INC. DS-DAC-10R] on usb-xhci-hcd.0-1/input3 6月 20 08:47:09 volumior5 kernel: input: pwr_button as /devices/platform/pwr_button/input/input0 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_info_register (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_info_create_module_entry (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_info_free_entry (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_fasync_helper (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_ecards_limit (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_oss_info_register (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_unregister_device (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_device_alloc (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_device_new (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_fasync_free (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_kill_fasync (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_register_device (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_info_register (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_info_create_module_entry (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_info_free_entry (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_fasync_helper (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_ecards_limit (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_oss_info_register (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_unregister_device (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_device_alloc (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_device_new (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_fasync_free (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_kill_fasync (err -2) 6月 20 08:47:09 volumior5 kernel: snd_timer: Unknown symbol snd_register_device (err -2) 6月 20 08:47:09 volumior5 kernel: brcmstb-i2c 107d508200.i2c: @97500hz registered in interrupt mode 6月 20 08:47:09 volumior5 kernel: brcmstb-i2c 107d508280.i2c: @97500hz registered in interrupt mode 6月 20 08:47:09 volumior5 kernel: [drm] Initialized v3d 1.0.0 20180419 for 1002000000.v3d on minor 0 6月 20 08:47:09 volumior5 kernel: fuse: init (API version 7.39) 6月 20 08:47:09 volumior5 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher 6月 20 08:47:09 volumior5 kernel: EXT4-fs (mmcblk0p2): mounted filesystem 7dd89884-34c6-4f67-9803-bf297d9c5536 r/w with ordered data mode. Quota mode: none. 6月 20 08:47:09 volumior5 kernel: loop0: detected capacity change from 0 to 1004352 6月 20 08:47:09 volumior5 kernel: EXT4-fs (mmcblk0p3): recovery complete 6月 20 08:47:09 volumior5 kernel: EXT4-fs (mmcblk0p3): mounted filesystem 48c13753-50c0-4277-abbb-34aba99569f4 r/w with ordered data mode. Quota mode: none. 6月 20 08:47:09 volumior5 kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038-01-19 (0x7fffffff) 6月 20 08:47:09 volumior5 kernel: NET: Registered PF_INET6 protocol family 6月 20 08:47:09 volumior5 kernel: Segment Routing with IPv6 6月 20 08:47:09 volumior5 kernel: In-situ OAM (IOAM) with IPv6 6月 20 08:47:09 volumior5 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) 6月 20 08:47:09 volumior5 systemd[1]: Detected architecture arm64. 6月 20 08:47:09 volumior5 systemd[1]: Set hostname to . 6月 20 08:47:09 volumior5 kernel: uart-pl011 107d001000.serial: no DMA platform data 6月 20 08:47:09 volumior5 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. 6月 20 08:47:09 volumior5 systemd[1]: Listening on fsck to fsckd communication Socket. 6月 20 08:47:09 volumior5 systemd[1]: Listening on RPCbind Server Activation Socket. 6月 20 08:47:09 volumior5 systemd[1]: Reached target System Time Synchronized. 6月 20 08:47:09 volumior5 systemd[1]: Listening on udev Control Socket. 6月 20 08:47:09 volumior5 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. 6月 20 08:47:09 volumior5 systemd[1]: Listening on Journal Socket (/dev/log). 6月 20 08:47:09 volumior5 kernel: i2c_dev: i2c /dev entries driver 6月 20 08:47:09 volumior5 systemd-journald[372]: Journal started 6月 20 08:47:09 volumior5 systemd-journald[372]: Runtime journal (/run/log/journal/b10dee12497433590070aee066eac464) is 3.7M, max 30.0M, 26.2M free. 6月 20 08:47:09 volumior5 systemd-modules-load[360]: Inserted module 'i2c_dev' 6月 20 08:47:09 volumior5 fake-hwclock[366]: Current system time: 2025-06-19 23:47:09 6月 20 08:47:09 volumior5 fake-hwclock[366]: fake-hwclock saved clock information is in the past: 2025-06-19 23:45:52 6月 20 08:47:09 volumior5 fake-hwclock[366]: To set system time to this saved clock anyway, use "force" 6月 20 08:47:09 volumior5 systemd[1]: Started Load/Save Random Seed. 6月 20 08:47:09 volumior5 systemd[1]: Started Create System Users. 6月 20 08:47:09 volumior5 systemd[1]: Started Apply Kernel Variables. 6月 20 08:47:09 volumior5 systemd[1]: Starting Create Static Device Nodes in /dev... 6月 20 08:47:09 volumior5 systemd[1]: Started Helper to synchronize boot up for ifupdown. 6月 20 08:47:09 volumior5 systemd[1]: dynamicswap.service: Succeeded. 6月 20 08:47:09 volumior5 systemd[1]: Started Create Static Device Nodes in /dev. 6月 20 08:47:09 volumior5 systemd[1]: Reached target Local File Systems (Pre). 6月 20 08:47:09 volumior5 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. 6月 20 08:47:09 volumior5 systemd[1]: Mounting /var/log... 6月 20 08:47:09 volumior5 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. 6月 20 08:47:09 volumior5 systemd[1]: Mounting /tmp... 6月 20 08:47:09 volumior5 systemd[1]: Mounting /var/spool/cups... 6月 20 08:47:09 volumior5 systemd[1]: Starting udev Kernel Device Manager... 6月 20 08:47:09 volumior5 systemd[1]: Mounted /var/log. 6月 20 08:47:09 volumior5 systemd[1]: Mounted /tmp. 6月 20 08:47:09 volumior5 systemd[1]: Mounted /var/spool/cups. 6月 20 08:47:09 volumior5 systemd[1]: Mounting /var/spool/cups/tmp... 6月 20 08:47:09 volumior5 systemd[1]: Starting Flush Journal to Persistent Storage... 6月 20 08:47:09 volumior5 systemd[1]: Mounted /var/spool/cups/tmp. 6月 20 08:47:09 volumior5 systemd-udevd[393]: Network interface NamePolicy= disabled on kernel command line, ignoring. 6月 20 08:47:09 volumior5 systemd-journald[372]: Runtime journal (/run/log/journal/b10dee12497433590070aee066eac464) is 3.7M, max 30.0M, 26.2M free. 6月 20 08:47:09 volumior5 systemd[1]: Started Flush Journal to Persistent Storage. 6月 20 08:47:09 volumior5 systemd[1]: Started udev Kernel Device Manager. 6月 20 08:47:09 volumior5 systemd[1]: Starting Show Plymouth Boot Screen... 6月 20 08:47:10 volumior5 systemd[1]: plymouth-start.service: Succeeded. 6月 20 08:47:10 volumior5 systemd[1]: Started Show Plymouth Boot Screen. 6月 20 08:47:10 volumior5 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. 6月 20 08:47:10 volumior5 systemd[1]: Reached target Paths. 6月 20 08:47:10 volumior5 systemd[1]: Reached target Local Encrypted Volumes. 6月 20 08:47:10 volumior5 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. 6月 20 08:47:10 volumior5 systemd-udevd[408]: Using default interface naming scheme 'v240'. 6月 20 08:47:10 volumior5 kernel: mc: Linux media interface: v0.10 6月 20 08:47:10 volumior5 kernel: videodev: Linux video capture interface: v2.00 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 6月 20 08:47:10 volumior5 kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 6月 20 08:47:10 volumior5 kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. 6月 20 08:47:10 volumior5 kernel: rpivid 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu 6月 20 08:47:10 volumior5 kernel: rpivid 1000800000.codec: Device registered as /dev/video19 6月 20 08:47:10 volumior5 systemd-udevd[408]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. 6月 20 08:47:10 volumior5 kernel: rp1_pio: Unknown symbol rp1_firmware_message (err -2) 6月 20 08:47:10 volumior5 kernel: rp1_pio: Unknown symbol devm_rp1_firmware_get (err -2) 6月 20 08:47:10 volumior5 kernel: rp1_pio: Unknown symbol rp1_firmware_get_feature (err -2) 6月 20 08:47:10 volumior5 kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu 6月 20 08:47:10 volumior5 kernel: pispbe 1000880000.pisp_be: Runtime PM usage count underflow! 6月 20 08:47:10 volumior5 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database 6月 20 08:47:10 volumior5 systemd[1]: Found device /dev/disk/by-uuid/4F45-7250. 6月 20 08:47:10 volumior5 systemd[1]: Found device /dev/ttyAMA10. 6月 20 08:47:10 volumior5 kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' 6月 20 08:47:10 volumior5 kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' 6月 20 08:47:10 volumior5 kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' 6月 20 08:47:10 volumior5 kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' 6月 20 08:47:10 volumior5 systemd[1]: Starting File System Check on /dev/disk/by-uuid/4F45-7250... 6月 20 08:47:10 volumior5 systemd-udevd[406]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. 6月 20 08:47:10 volumior5 systemd[1]: Started File System Check Daemon to report status. 6月 20 08:47:10 volumior5 kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 6月 20 08:47:10 volumior5 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 6月 20 08:47:10 volumior5 kernel: usbcore: registered new interface driver brcmfmac 6月 20 08:47:10 volumior5 kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,5-model-b.bin failed with error -2 6月 20 08:47:10 volumior5 systemd-udevd[411]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) 6月 20 08:47:10 volumior5 kernel: Registered IR keymap rc-cec 6月 20 08:47:10 volumior5 kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0 6月 20 08:47:10 volumior5 kernel: input: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0/input1 6月 20 08:47:10 volumior5 kernel: input: vc4-hdmi-0 HDMI Jack as /devices/platform/soc/107c701400.hdmi/sound/card0/input2 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) 6月 20 08:47:10 volumior5 kernel: Registered IR keymap rc-cec 6月 20 08:47:10 volumior5 kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1 6月 20 08:47:10 volumior5 kernel: input: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1/input3 6月 20 08:47:10 volumior5 kernel: input: vc4-hdmi-1 HDMI Jack as /devices/platform/soc/107c706400.hdmi/sound/card1/input4 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) 6月 20 08:47:10 volumior5 kernel: Bluetooth: Core ver 2.22 6月 20 08:47:10 volumior5 kernel: NET: Registered PF_BLUETOOTH protocol family 6月 20 08:47:10 volumior5 kernel: Bluetooth: HCI device and connection manager initialized 6月 20 08:47:10 volumior5 kernel: Bluetooth: HCI socket layer initialized 6月 20 08:47:10 volumior5 kernel: Bluetooth: L2CAP socket layer initialized 6月 20 08:47:10 volumior5 kernel: Bluetooth: SCO socket layer initialized 6月 20 08:47:10 volumior5 kernel: [drm] Initialized vc4 0.0.0 20140616 for axi:gpu on minor 1 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes 6月 20 08:47:10 volumior5 kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes 6月 20 08:47:10 volumior5 kernel: usbcore: registered new interface driver snd-usb-audio 6月 20 08:47:10 volumior5 kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) 6月 20 08:47:10 volumior5 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 6月 20 08:47:10 volumior5 kernel: Bluetooth: HCI UART driver ver 2.3 6月 20 08:47:10 volumior5 kernel: Bluetooth: HCI UART protocol H4 registered 6月 20 08:47:10 volumior5 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered 6月 20 08:47:10 volumior5 kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator 6月 20 08:47:11 volumior5 kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator 6月 20 08:47:11 volumior5 kernel: Bluetooth: HCI UART protocol Broadcom registered 6月 20 08:47:10 volumior5 systemd-udevd[404]: Using default interface naming scheme 'v240'. 6月 20 08:47:10 volumior5 systemd-udevd[404]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. 6月 20 08:47:11 volumior5 systemd-udevd[400]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. 6月 20 08:47:11 volumior5 systemd-udevd[405]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. 6月 20 08:47:11 volumior5 systemd-udevd[410]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. 6月 20 08:47:11 volumior5 systemd-udevd[408]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. 6月 20 08:47:11 volumior5 systemd-fsck[509]: fsck.fat 4.1 (2017-01-24) 6月 20 08:47:11 volumior5 systemd-fsck[509]: /dev/mmcblk0p1: 400 files, 166324/184582 clusters 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Started File System Check on /dev/disk/by-uuid/4F45-7250. 6月 20 08:47:11 volumior5 kernel: Bluetooth: hci0: BCM: chip id 107 6月 20 08:47:11 volumior5 kernel: Bluetooth: hci0: BCM: features 0x2f 6月 20 08:47:11 volumior5 kernel: Bluetooth: hci0: BCM4345C0 6月 20 08:47:11 volumior5 kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 6月 20 08:47:11 volumior5 kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch 6月 20 08:47:11 volumior5 kernel: alsactl[629]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set 6月 20 08:47:11 volumior5 systemd-udevd[398]: Process '/bin/bash -c '/usr/local/bin/volumio scanaudioinputs'' failed with exit code 7. 6月 20 08:47:11 volumior5 systemd-udevd[407]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. 6月 20 08:47:11 volumior5 systemd[1]: Created slice system-bthelper.slice. 6月 20 08:47:11 volumior5 systemd[1]: Starting Show Plymouth Boot Screen... 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in Huge Pages File System being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Mounting /boot... 6月 20 08:47:11 volumior5 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. 6月 20 08:47:11 volumior5 systemd[1]: Starting Load/Save RF Kill Switch Status... 6月 20 08:47:11 volumior5 systemd[1]: Found device /sys/subsystem/net/devices/wlan0. 6月 20 08:47:11 volumior5 systemd[1]: Started Load/Save RF Kill Switch Status. 6月 20 08:47:11 volumior5 systemd[1]: plymouth-start.service: Succeeded. 6月 20 08:47:11 volumior5 systemd[1]: Started Show Plymouth Boot Screen. 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Mounted /boot. 6月 20 08:47:11 volumior5 systemd[1]: Reached target Local File Systems. 6月 20 08:47:11 volumior5 systemd[1]: Started ifup for wlan0. 6月 20 08:47:11 volumior5 systemd[1]: Starting Create Volatile Files and Directories... 6月 20 08:47:11 volumior5 systemd[1]: Starting Raise network interfaces... 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Started ifup for eth0. 6月 20 08:47:11 volumior5 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... 6月 20 08:47:11 volumior5 systemd[1]: Starting Preprocess NFS configuration... 6月 20 08:47:11 volumior5 systemd[1]: Received SIGRTMIN+20 from PID 253 (plymouthd). 6月 20 08:47:11 volumior5 systemd[1]: plymouth-read-write.service: Succeeded. 6月 20 08:47:11 volumior5 systemd[1]: Started Tell Plymouth To Write Out Runtime Data. 6月 20 08:47:11 volumior5 systemd[1]: nfs-config.service: Succeeded. 6月 20 08:47:11 volumior5 systemd[1]: Started Preprocess NFS configuration. 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Reached target NFS client services. 6月 20 08:47:11 volumior5 kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 6月 20 08:47:11 volumior5 systemd[1]: Started Create Volatile Files and Directories. 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in Network Time Synchronization being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Started Entropy daemon using the HAVEGE algorithm. 6月 20 08:47:11 volumior5 systemd[1]: Starting RPC bind portmap service... 6月 20 08:47:11 volumior5 systemd[1]: Starting Update UTMP about System Boot/Shutdown... 6月 20 08:47:11 volumior5 systemd[1]: Started Update UTMP about System Boot/Shutdown. 6月 20 08:47:11 volumior5 systemd[1]: Reached target System Initialization. 6月 20 08:47:11 volumior5 systemd[1]: Started Daily Cleanup of Temporary Directories. 6月 20 08:47:11 volumior5 systemd[1]: Listening on triggerhappy.socket. 6月 20 08:47:11 volumior5 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. 6月 20 08:47:11 volumior5 systemd[1]: Started Daily apt download activities. 6月 20 08:47:11 volumior5 systemd[1]: Started Daily apt upgrade and clean activities. 6月 20 08:47:11 volumior5 systemd[1]: Reached target Timers. 6月 20 08:47:11 volumior5 systemd[1]: Listening on D-Bus System Message Bus Socket. 6月 20 08:47:11 volumior5 systemd[1]: Reached target Sockets. 6月 20 08:47:11 volumior5 systemd[1]: Reached target Basic System. 6月 20 08:47:11 volumior5 dhclient[730]: Internet Systems Consortium DHCP Client 4.4.1 6月 20 08:47:11 volumior5 sh[659]: Internet Systems Consortium DHCP Client 4.4.1 6月 20 08:47:11 volumior5 sh[659]: Copyright 2004-2018 Internet Systems Consortium. 6月 20 08:47:11 volumior5 sh[659]: All rights reserved. 6月 20 08:47:11 volumior5 sh[659]: For info, please visit https://www.isc.org/software/dhcp/ 6月 20 08:47:11 volumior5 systemd[1]: Starting Restore /etc/resolv.conf if the system crashed before the ppp link was shut down... 6月 20 08:47:11 volumior5 sh[667]: Internet Systems Consortium DHCP Client 4.4.1 6月 20 08:47:11 volumior5 sh[667]: Copyright 2004-2018 Internet Systems Consortium. 6月 20 08:47:11 volumior5 sh[667]: All rights reserved. 6月 20 08:47:11 volumior5 sh[667]: For info, please visit https://www.isc.org/software/dhcp/ 6月 20 08:47:11 volumior5 dhclient[730]: Copyright 2004-2018 Internet Systems Consortium. 6月 20 08:47:11 volumior5 dhclient[730]: All rights reserved. 6月 20 08:47:11 volumior5 dhclient[730]: For info, please visit https://www.isc.org/software/dhcp/ 6月 20 08:47:11 volumior5 dhclient[730]: 6月 20 08:47:11 volumior5 dhclient[731]: Internet Systems Consortium DHCP Client 4.4.1 6月 20 08:47:11 volumior5 dhclient[731]: Copyright 2004-2018 Internet Systems Consortium. 6月 20 08:47:11 volumior5 dhclient[731]: All rights reserved. 6月 20 08:47:11 volumior5 dhclient[731]: For info, please visit https://www.isc.org/software/dhcp/ 6月 20 08:47:11 volumior5 dhclient[731]: 6月 20 08:47:11 volumior5 systemd[1]: Starting triggerhappy global hotkey daemon... 6月 20 08:47:11 volumior5 systemd[1]: Started MPD Monitor Service. 6月 20 08:47:11 volumior5 kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) 6月 20 08:47:11 volumior5 kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode 6月 20 08:47:11 volumior5 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. 6月 20 08:47:11 volumior5 systemd[1]: Started UPnP Renderer front-end to MPD. 6月 20 08:47:11 volumior5 thd[745]: Unable to parse trigger line: 6月 20 08:47:11 volumior5 thd[745]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle 6月 20 08:47:11 volumior5 thd[745]: Unable to parse trigger line: 6月 20 08:47:12 volumior5 kernel: pps pps0: new PPS source ptp0 6月 20 08:47:12 volumior5 kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. 6月 20 08:47:12 volumior5 thd[745]: Found socket passed from systemd 6月 20 08:47:12 volumior5 systemd[1]: Started Volumio Log Rotation Service. 6月 20 08:47:12 volumior5 systemd[1]: Started Volumio Iptables Module. 6月 20 08:47:12 volumior5 mpd_monitor.sh[746]: MPD Monitor Service: Starting MPD Monitor Service 6月 20 08:47:12 volumior5 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. 6月 20 08:47:12 volumior5 systemd[1]: Starting Wireless Services... 6月 20 08:47:12 volumior5 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... 6月 20 08:47:12 volumior5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled 6月 20 08:47:12 volumior5 systemd[1]: Started D-Bus System Message Bus. 6月 20 08:47:12 volumior5 systemd[1]: Starting WPA supplicant... 6月 20 08:47:12 volumior5 systemd[1]: Started volumio-remote-updater.service. 6月 20 08:47:12 volumior5 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. 6月 20 08:47:12 volumior5 kernel: Bluetooth: hci0: BCM: features 0x2f 6月 20 08:47:12 volumior5 kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ 6月 20 08:47:12 volumior5 kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 6月 20 08:47:12 volumior5 kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) 6月 20 08:47:12 volumior5 systemd[1]: Starting Modem Manager... 6月 20 08:47:12 volumior5 systemd[1]: Starting Network Manager... 6月 20 08:47:12 volumior5 systemd[1]: Starting Login Service... 6月 20 08:47:12 volumior5 systemd[1]: Starting Volumio Time Update Utility... 6月 20 08:47:12 volumior5 systemd[1]: Starting dhcpcd on all interfaces... 6月 20 08:47:12 volumior5 systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. 6月 20 08:47:12 volumior5 systemd[1]: Starting Raspberry Pi bluetooth helper... 6月 20 08:47:12 volumior5 systemd[1]: Started Manage Sound Card State (restore and store). 6月 20 08:47:12 volumior5 systemd[1]: Starting Save/Restore Sound Card State... 6月 20 08:47:12 volumior5 systemd[1]: Started RPC bind portmap service. 6月 20 08:47:12 volumior5 systemd[1]: Started triggerhappy global hotkey daemon. 6月 20 08:47:12 volumior5 alsactl[767]: alsactl 1.1.8 daemon started 6月 20 08:47:12 volumior5 systemd[1]: Reached target RPC Port Mapper. 6月 20 08:47:12 volumior5 systemd[1]: Reached target Remote File Systems (Pre). 6月 20 08:47:12 volumior5 systemd[1]: Reached target Remote File Systems. 6月 20 08:47:12 volumior5 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... 6月 20 08:47:12 volumior5 systemd[1]: Starting LSB: Switch to ondemand cpu governor (unless shift key is pressed)... 6月 20 08:47:12 volumior5 systemd[1]: Started Regular background program processing daemon. 6月 20 08:47:12 volumior5 cron[771]: (CRON) INFO (pidfile fd = 3) 6月 20 08:47:12 volumior5 dhclient[731]: Listening on LPF/eth0/2c:cf:67:76:58:28 6月 20 08:47:12 volumior5 sh[659]: Listening on LPF/wlan0/2c:cf:67:76:58:29 6月 20 08:47:12 volumior5 sh[659]: Sending on LPF/wlan0/2c:cf:67:76:58:29 6月 20 08:47:12 volumior5 sh[659]: Sending on Socket/fallback 6月 20 08:47:12 volumior5 sh[659]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 3 6月 20 08:47:12 volumior5 dhclient[730]: Listening on LPF/wlan0/2c:cf:67:76:58:29 6月 20 08:47:12 volumior5 sh[667]: Listening on LPF/eth0/2c:cf:67:76:58:28 6月 20 08:47:12 volumior5 sh[667]: Sending on LPF/eth0/2c:cf:67:76:58:28 6月 20 08:47:12 volumior5 sh[667]: Sending on Socket/fallback 6月 20 08:47:12 volumior5 sh[667]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7 6月 20 08:47:12 volumior5 dhclient[730]: Sending on LPF/wlan0/2c:cf:67:76:58:29 6月 20 08:47:12 volumior5 dhclient[731]: Sending on LPF/eth0/2c:cf:67:76:58:28 6月 20 08:47:12 volumior5 dhclient[730]: Sending on Socket/fallback 6月 20 08:47:12 volumior5 dhclient[731]: Sending on Socket/fallback 6月 20 08:47:12 volumior5 dhclient[730]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 3 6月 20 08:47:12 volumior5 dhclient[731]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7 6月 20 08:47:12 volumior5 dhcpcd[765]: Not running dhcpcd because /etc/network/interfaces 6月 20 08:47:12 volumior5 dhcpcd[765]: defines some interfaces that will use a 6月 20 08:47:12 volumior5 dhcpcd[765]: DHCP client or static address 6月 20 08:47:12 volumior5 cron[771]: (CRON) INFO (Running @reboot jobs) 6月 20 08:47:12 volumior5 volumio-time-update[764]: volumio-time-update-util: Fetching time from Volumio... 6月 20 08:47:12 volumior5 systemd-logind[763]: New seat seat0. 6月 20 08:47:12 volumior5 systemd-logind[763]: Watching system buttons on /dev/input/event0 (pwr_button) 6月 20 08:47:12 volumior5 systemd-logind[763]: Watching system buttons on /dev/input/event1 (vc4-hdmi-0) 6月 20 08:47:12 volumior5 systemd-logind[763]: Watching system buttons on /dev/input/event3 (vc4-hdmi-1) 6月 20 08:47:12 volumior5 bthelper[766]: Raspberry Pi BDADDR already set 6月 20 08:47:12 volumior5 mpd_monitor.sh[746]: MPD error: Connection refused 6月 20 08:47:12 volumior5 mpd_monitor.sh[746]: MPD Monitor Service: MPD Appears to be inactive, restarting 6月 20 08:47:12 volumior5 haveged[710]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K 6月 20 08:47:12 volumior5 haveged[710]: haveged: cpu: (VC); data: 64K (V); inst: 64K (V); idx: 39/40; sz: 63488/63488 6月 20 08:47:12 volumior5 haveged[710]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.9949 6月 20 08:47:12 volumior5 haveged[710]: haveged: fills: 0, generated: 0 6月 20 08:47:12 volumior5 mpd_monitor.sh[746]: mpd: no process found 6月 20 08:47:12 volumior5 avahi-daemon[753]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). 6月 20 08:47:12 volumior5 avahi-daemon[753]: Successfully dropped root privileges. 6月 20 08:47:12 volumior5 avahi-daemon[753]: avahi-daemon 0.7 starting up. 6月 20 08:47:12 volumior5 volumio-remote-updater[758]: Error: No active session 6月 20 08:47:12 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:12] [info] asio async_connect error: system:111 (Connection refused) 6月 20 08:47:12 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) 6月 20 08:47:12 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:12] [error] handle_connect error: Underlying Transport Error 6月 20 08:47:12 volumior5 volumio-time-update[764]: volumio-time-update-util: Date not found in response 6月 20 08:47:12 volumior5 volumio-time-update[764]: volumio-time-update-util: Retrying in 5 seconds... 6月 20 08:47:12 volumior5 ModemManager[760]: ModemManager (version 1.10.0) starting in system bus... 6月 20 08:47:13 volumior5 volumio[747]: Could not open config: /tmp/upmpdcli.conf 6月 20 08:47:13 volumior5 systemd[1]: Started Login Service. 6月 20 08:47:13 volumior5 systemd[1]: pppd-dns.service: Succeeded. 6月 20 08:47:13 volumior5 avahi-daemon[753]: Successfully called chroot(). 6月 20 08:47:13 volumior5 systemd[1]: Started Restore /etc/resolv.conf if the system crashed before the ppp link was shut down. 6月 20 08:47:13 volumior5 avahi-daemon[753]: Successfully dropped remaining capabilities. 6月 20 08:47:13 volumior5 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE 6月 20 08:47:13 volumior5 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. 6月 20 08:47:13 volumior5 systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED 6月 20 08:47:13 volumior5 systemd[1]: dhcpcd.service: Failed with result 'exit-code'. 6月 20 08:47:13 volumior5 wpa_supplicant[757]: Successfully initialized wpa_supplicant 6月 20 08:47:13 volumior5 systemd[1]: Failed to start dhcpcd on all interfaces. 6月 20 08:47:13 volumior5 systemd[1]: Started Raspberry Pi bluetooth helper. 6月 20 08:47:13 volumior5 systemd[1]: Started Save/Restore Sound Card State. 6月 20 08:47:13 volumior5 dbus-daemon[754]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.4' (uid=0 pid=760 comm="/usr/sbin/ModemManager --filter-policy=strict ") 6月 20 08:47:13 volumior5 avahi-daemon[753]: Loading service file /services/volumio.service. 6月 20 08:47:13 volumior5 avahi-daemon[753]: Network interface enumeration completed. 6月 20 08:47:13 volumior5 avahi-daemon[753]: Server startup complete. Host name is volumior5.local. Local service cookie is 1170185099. 6月 20 08:47:13 volumior5 avahi-daemon[753]: Service "VolumioR5" (/services/volumio.service) successfully established. 6月 20 08:47:13 volumior5 systemd[1]: Started Raise network interfaces. 6月 20 08:47:13 volumior5 systemd[1]: iptables.service: Succeeded. 6月 20 08:47:13 volumior5 systemd[1]: Started Avahi mDNS/DNS-SD Stack. 6月 20 08:47:13 volumior5 systemd[1]: Started WPA supplicant. 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.2051] NetworkManager (version 1.14.6) is starting... (for the first time) 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.2051] Read config: /etc/NetworkManager/NetworkManager.conf (lib: no-mac-addr-change.conf) 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.2266] wifi-nl80211: (wlan0): using nl80211 for WiFi device control 6月 20 08:47:13 volumior5 loadcpufreq[769]: Loading cpufreq kernel modules...done (none). 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.2395] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager" 6月 20 08:47:13 volumior5 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. 6月 20 08:47:13 volumior5 systemd[1]: Started Network Manager. 6月 20 08:47:13 volumior5 systemd[1]: Starting Network Manager Wait Online... 6月 20 08:47:13 volumior5 systemd[1]: Starting LSB: set CPUFreq kernel parameters... 6月 20 08:47:13 volumior5 systemd[1]: Starting Authorization Manager... 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.2557] manager[0x14a2018]: monitoring kernel firmware directory '/lib/firmware'. 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.2558] monitoring ifupdown state file '/run/network/ifstate'. 6月 20 08:47:13 volumior5 systemd[1]: Listening on mpd.socket. 6月 20 08:47:13 volumior5 systemd[1]: Reached target Sound Card. 6月 20 08:47:13 volumior5 systemd[1]: Starting Bluetooth service... 6月 20 08:47:13 volumior5 systemd[1]: Reached target Network. 6月 20 08:47:13 volumior5 systemd[1]: Started Supervisor process control system for UNIX. 6月 20 08:47:13 volumior5 dbus-daemon[754]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=762 comm="/usr/sbin/NetworkManager --no-daemon ") 6月 20 08:47:13 volumior5 systemd[1]: Starting Network Time Service... 6月 20 08:47:13 volumior5 systemd[1]: Starting OpenBSD Secure Shell server... 6月 20 08:47:13 volumior5 systemd[1]: Starting Permit User Sessions... 6月 20 08:47:13 volumior5 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. 6月 20 08:47:13 volumior5 systemd[1]: Starting Music Player Daemon... 6月 20 08:47:13 volumior5 bluetoothd[882]: Bluetooth daemon 5.50 6月 20 08:47:13 volumior5 bluetoothd[882]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf 6月 20 08:47:13 volumior5 bluetoothd[882]: Starting SDP server 6月 20 08:47:13 volumior5 bluetoothd[882]: Excluding (cli) sap 6月 20 08:47:13 volumior5 ntpd[884]: ntpd 4.2.8p12@1.3728-o (1): Starting 6月 20 08:47:13 volumior5 ntpd[884]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 6月 20 08:47:13 volumior5 ntpd[904]: proto: precision = 0.574 usec (-21) 6月 20 08:47:13 volumior5 systemd[1]: Started Network Time Service. 6月 20 08:47:13 volumior5 systemd[1]: Started Permit User Sessions. 6月 20 08:47:13 volumior5 systemd[1]: Started Bluetooth service. 6月 20 08:47:13 volumior5 systemd[1]: Reached target Bluetooth. 6月 20 08:47:13 volumior5 sshd[906]: Server listening on 0.0.0.0 port 22. 6月 20 08:47:13 volumior5 sshd[906]: Server listening on :: port 22. 6月 20 08:47:13 volumior5 ntpd[904]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature 6月 20 08:47:13 volumior5 systemd[1]: Starting Hostname Service... 6月 20 08:47:13 volumior5 ntpd[904]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 6月 20 08:47:13 volumior5 systemd[1]: Started OpenBSD Secure Shell server. 6月 20 08:47:13 volumior5 ntpd[904]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 174 days ago 6月 20 08:47:13 volumior5 ntpd[904]: Listen and drop on 0 v6wildcard [::]:123 6月 20 08:47:13 volumior5 ntpd[904]: Listen and drop on 1 v4wildcard 0.0.0.0:123 6月 20 08:47:13 volumior5 ntpd[904]: Listen normally on 2 lo 127.0.0.1:123 6月 20 08:47:13 volumior5 ntpd[904]: Listening on routing socket on fd #19 for interface updates 6月 20 08:47:13 volumior5 ntpd[904]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:47:13 volumior5 ntpd[904]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:47:13 volumior5 bluetoothd[882]: Bluetooth management interface 1.22 initialized 6月 20 08:47:13 volumior5 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 6月 20 08:47:13 volumior5 kernel: Bluetooth: BNEP filters: protocol multicast 6月 20 08:47:13 volumior5 kernel: Bluetooth: BNEP socket layer initialized 6月 20 08:47:13 volumior5 kernel: Bluetooth: MGMT ver 1.22 6月 20 08:47:13 volumior5 dbus-daemon[754]: [system] Successfully activated service 'org.freedesktop.hostname1' 6月 20 08:47:13 volumior5 systemd[1]: Started Hostname Service. 6月 20 08:47:13 volumior5 polkitd[878]: started daemon version 0.105 using authority implementation `local' version `0.105' 6月 20 08:47:13 volumior5 dbus-daemon[754]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' 6月 20 08:47:13 volumior5 systemd[1]: Started Authorization Manager. 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.8735] hostname: hostname: using hostnamed 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.8735] hostname: hostname changed from (none) to "volumior5" 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.8887] dns-mgr[0x14b4800]: init: dns=default, rc-manager=resolvconf 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.8896] rfkill0: found WiFi radio killswitch (at /sys/devices/platform/axi/1001100000.mmc/mmc_host/mmc1/mmc1:0001/mmc1:0001:1/ieee80211/phy0/rfkill0) (driver brcmfmac) 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.8899] manager[0x14a2018]: rfkill: WiFi hardware radio set enabled 6月 20 08:47:13 volumior5 NetworkManager[762]: [1750376833.8900] manager[0x14a2018]: rfkill: WWAN hardware radio set enabled 6月 20 08:47:13 volumior5 bluetoothd[882]: Failed to set privacy: Rejected (0x0b) 6月 20 08:47:13 volumior5 cpufrequtils[877]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. 6月 20 08:47:13 volumior5 systemd[1]: Started LSB: set CPUFreq kernel parameters. 6月 20 08:47:13 volumior5 dbus-daemon[754]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.5' (uid=0 pid=762 comm="/usr/sbin/NetworkManager --no-daemon ") 6月 20 08:47:14 volumior5 sudo[897]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log 6月 20 08:47:14 volumior5 sudo[897]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:14 volumior5 sudo[897]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory 6月 20 08:47:14 volumior5 sudo[897]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:14 volumior5 systemd[1]: Starting Network Manager Script Dispatcher Service... 6月 20 08:47:14 volumior5 dbus-daemon[754]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' 6月 20 08:47:14 volumior5 systemd[1]: Started Network Manager Script Dispatcher Service. 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1153] ifupdown: interface-parser: parsing file /etc/network/interfaces 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1153] ifupdown: interface-parser: finished parsing file /etc/network/interfaces 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1229] ifupdown: guessed connection type (eth0) = 802-3-ethernet 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1230] ifupdown: update_connection_setting_from_if_block: name:eth0, type:802-3-ethernet, id:Ifupdown (eth0), uuid: 681b428f-beaf-8932-dce4-687ed5bae28e 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1233] ifupdown: guessed connection type (wlan0) = 802-3-ethernet 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1234] ifupdown: update_connection_setting_from_if_block: name:wlan0, type:802-3-ethernet, id:Ifupdown (wlan0), uuid: 5391eba4-6426-faca-338e-5828034ff9d1 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1234] ifupdown: management mode: unmanaged 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1235] settings: Loaded settings plugin: SettingsPluginIfupdown ("/usr/lib/arm-linux-gnueabihf/NetworkManager/1.14.6/libnm-settings-plugin-ifupdown.so") 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1235] settings: Loaded settings plugin: NMSKeyfilePlugin (internal) 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1293] manager: rfkill: WiFi enabled by radio killswitch; enabled by state file 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1294] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1295] manager: Networking is enabled by state file 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1296] dhcp-init: Using DHCP client 'dhclient' 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.1552] Loaded device plugin: NMAtmManager (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.14.6/libnm-device-plugin-adsl.so) 6月 20 08:47:14 volumior5 nm-dispatcher[921]: req:1 'hostname': new request (2 scripts) 6月 20 08:47:14 volumior5 nm-dispatcher[921]: req:1 'hostname': start running ordered scripts... 6月 20 08:47:14 volumior5 systemd[1]: Started Modem Manager. 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.2011] Loaded device plugin: NMBluezManager (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.14.6/libnm-device-plugin-bluetooth.so) 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.2148] Loaded device plugin: NMWifiFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.14.6/libnm-device-plugin-wifi.so) 6月 20 08:47:14 volumior5 raspi-config[770]: Checking if shift key is held down: No. Switching to ondemand scaling governor. 6月 20 08:47:14 volumior5 systemd[1]: Started LSB: Switch to ondemand cpu governor (unless shift key is pressed). 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3218] Loaded device plugin: NMTeamFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.14.6/libnm-device-plugin-team.so) 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3268] Loaded device plugin: NMWwanFactory (/usr/lib/arm-linux-gnueabihf/NetworkManager/1.14.6/libnm-device-plugin-wwan.so) 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3367] device (lo): carrier: link connected 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3371] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1) 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3384] manager: (eth0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2) 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3428] device (wlan0): driver supports Access Point (AP) mode 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3434] manager: (wlan0): new 802.11 WiFi device (/org/freedesktop/NetworkManager/Devices/3) 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3584] manager: NetworkManager state is now CONNECTED_GLOBAL 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.3779] manager: startup complete 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.4006] supplicant: wpa_supplicant running 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.4010] bluez: use BlueZ version 5 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.4014] modem-manager: ModemManager available 6月 20 08:47:14 volumior5 systemd[1]: Started Network Manager Wait Online. 6月 20 08:47:14 volumior5 systemd[1]: Reached target Network is Online. 6月 20 08:47:14 volumior5 NetworkManager[762]: [1750376834.4065] bluez5: NAP: added interface 2C:CF:67:76:58:2A 6月 20 08:47:14 volumior5 systemd[1]: Starting /etc/rc.local Compatibility... 6月 20 08:47:14 volumior5 systemd[1]: Starting LSB: exim Mail Transport Agent... 6月 20 08:47:14 volumior5 systemd[1]: Starting LSB: Netplan calendar service.... 6月 20 08:47:14 volumior5 systemd[1]: Starting Samba NMB Daemon... 6月 20 08:47:14 volumior5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. 6月 20 08:47:14 volumior5 systemd[1]: Starting LSB: Brings up/down network automatically... 6月 20 08:47:14 volumior5 systemd[1]: Started /etc/rc.local Compatibility. 6月 20 08:47:14 volumior5 systemd[1]: Starting Hold until boot process finishes up... 6月 20 08:47:14 volumior5 systemd[1]: Starting Terminate Plymouth Boot Screen... 6月 20 08:47:14 volumior5 systemd[1]: Received SIGRTMIN+21 from PID 253 (plymouthd). 6月 20 08:47:14 volumior5 systemd[1]: plymouth-quit-wait.service: Succeeded. 6月 20 08:47:14 volumior5 systemd[1]: Started Hold until boot process finishes up. 6月 20 08:47:14 volumior5 systemd[1]: plymouth-quit.service: Succeeded. 6月 20 08:47:14 volumior5 systemd[1]: Started Terminate Plymouth Boot Screen. 6月 20 08:47:14 volumior5 systemd[1]: Received SIGRTMIN+21 from PID 253 (n/a). 6月 20 08:47:14 volumior5 netplan[930]: Netplan daemon not enabled in /etc/init.d/netplan. 6月 20 08:47:14 volumior5 systemd[1]: Started Serial Getty on ttyAMA10. 6月 20 08:47:14 volumior5 ifplugd(eth0)[958]: ifplugd 0.28 initializing. 6月 20 08:47:14 volumior5 systemd[1]: Started Getty on tty1. 6月 20 08:47:14 volumior5 ifplugd(eth0)[958]: Using interface eth0/2C:CF:67:76:58:28 with driver (version: 6.6.62-v8+) 6月 20 08:47:14 volumior5 systemd[1]: Reached target Login Prompts. 6月 20 08:47:14 volumior5 ifplugd(eth0)[958]: Using detection mode: SIOCETHTOOL 6月 20 08:47:14 volumior5 ifplugd(eth0)[958]: Initialization complete, link beat not detected. 6月 20 08:47:14 volumior5 systemd[1]: Started LSB: Netplan calendar service.. 6月 20 08:47:14 volumior5 ifplugd[933]: Network Interface Plugging Daemon...start eth0...done. 6月 20 08:47:14 volumior5 systemd[1]: Started LSB: Brings up/down network automatically. 6月 20 08:47:14 volumior5 ntpd[904]: error resolving pool 0.debian.pool.ntp.org: System error (-11) 6月 20 08:47:15 volumior5 exim4[929]: Starting MTA: exim4. 6月 20 08:47:15 volumior5 systemd[1]: Started LSB: exim Mail Transport Agent. 6月 20 08:47:15 volumior5 exim[1205]: 2025-06-20 08:47:15 socket bind() to port 25 for address ::1 failed: Cannot assign requested address: waiting 30s before trying again (9 more tries) 6月 20 08:47:15 volumior5 exim[1205]: 2025-06-20 08:47:15 Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=0 egid=124 6月 20 08:47:15 volumior5 exim[1205]: exim: could not open panic log - aborting: see message(s) above 6月 20 08:47:15 volumior5 wireless.js[752]: Cleaning previous... 6月 20 08:47:15 volumior5 dhclient[730]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 5 6月 20 08:47:15 volumior5 sh[659]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 5 6月 20 08:47:15 volumior5 sudo[1215]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 6月 20 08:47:15 volumior5 sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:15 volumior5 sudo[1215]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:15 volumior5 sudo[1217]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down 6月 20 08:47:15 volumior5 sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:15 volumior5 nmbd[937]: [2025/06/20 08:47:15.675665, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) 6月 20 08:47:15 volumior5 nmbd[937]: started asyncdns process 1219 6月 20 08:47:15 volumior5 ntpd[904]: error resolving pool 1.debian.pool.ntp.org: System error (-11) 6月 20 08:47:16 volumior5 dhclient[730]: receive_packet failed on wlan0: Network is down 6月 20 08:47:16 volumior5 sh[659]: receive_packet failed on wlan0: Network is down 6月 20 08:47:16 volumior5 nmbd[937]: [2025/06/20 08:47:16.190047, 0] ../lib/util/become_daemon.c:149(daemon_status) 6月 20 08:47:16 volumior5 nmbd[937]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... 6月 20 08:47:16 volumior5 nmbd[937]: [2025/06/20 08:47:16.190126, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) 6月 20 08:47:16 volumior5 nmbd[937]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). 6月 20 08:47:16 volumior5 sudo[1217]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:16 volumior5 wireless.js[752]: Stopped aP 6月 20 08:47:16 volumior5 sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up 6月 20 08:47:16 volumior5 sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:16 volumior5 sudo[1225]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:16 volumior5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled 6月 20 08:47:16 volumior5 sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get 6月 20 08:47:16 volumior5 sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:16 volumior5 sudo[1227]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:16 volumior5 sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up 6月 20 08:47:16 volumior5 sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:16 volumior5 sudo[1234]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:16 volumior5 sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan 6月 20 08:47:16 volumior5 sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:16 volumior5 ntpd[904]: error resolving pool 2.debian.pool.ntp.org: System error (-11) 6月 20 08:47:16 volumior5 ModemManager[760]: Couldn't check support for device '/sys/devices/platform/axi/1000120000.pcie/1f00100000.ethernet': not supported by any plugin 6月 20 08:47:16 volumior5 ModemManager[760]: Couldn't check support for device '/sys/devices/platform/axi/1001100000.mmc/mmc_host/mmc1/mmc1:0001/mmc1:0001:1': not supported by any plugin 6月 20 08:47:16 volumior5 systemd[1]: systemd-rfkill.service: Succeeded. 6月 20 08:47:16 volumior5 supervisord[883]: 2025-06-20 08:47:16,822 CRIT Supervisor is running as root. Privileges were not dropped because no user is specified in the config file. If you intend to run as root, you can set user=root in the config file to avoid this message. 6月 20 08:47:16 volumior5 supervisord[883]: 2025-06-20 08:47:16,822 INFO Included extra file "/etc/supervisor/conf.d/radiko.conf" during parsing 6月 20 08:47:16 volumior5 mpd[920]: Jun 20 08:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg 6月 20 08:47:16 volumior5 supervisord[883]: 2025-06-20 08:47:16,889 INFO RPC interface 'supervisor' initialized 6月 20 08:47:16 volumior5 supervisord[883]: 2025-06-20 08:47:16,889 INFO supervisord started with pid 883 6月 20 08:47:16 volumior5 systemd[1]: Started Music Player Daemon. 6月 20 08:47:16 volumior5 mpd_monitor.sh[746]: MPD Monitor Service: MPD restarted due to no mpc output. 6月 20 08:47:17 volumior5 bthelper[766]: Changing power off succeeded 6月 20 08:47:17 volumior5 bthelper[766]: [CHG] Controller 2C:CF:67:76:58:2A Class: 0x0000041c 6月 20 08:47:17 volumior5 bthelper[766]: Changing power on succeeded 6月 20 08:47:17 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:17] [info] asio async_connect error: system:111 (Connection refused) 6月 20 08:47:17 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) 6月 20 08:47:17 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:17] [error] handle_connect error: Underlying Transport Error 6月 20 08:47:17 volumior5 ntpd[904]: error resolving pool 3.debian.pool.ntp.org: System error (-11) 6月 20 08:47:17 volumior5 volumio-time-update[764]: volumio-time-update-util: Fetching time from Volumio... 6月 20 08:47:17 volumior5 volumio-time-update[764]: volumio-time-update-util: Date not found in response 6月 20 08:47:17 volumior5 volumio-time-update[764]: volumio-time-update-util: Retrying in 5 seconds... 6月 20 08:47:17 volumior5 supervisord[883]: 2025-06-20 08:47:17,895 INFO spawned: 'radiko' with pid 1251 6月 20 08:47:18 volumior5 supervisord[883]: 2025-06-20 08:47:18,785 INFO exited: radiko (exit status 1; not expected) 6月 20 08:47:18 volumior5 sudo[1236]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:18 volumior5 wireless.js[752]: SETTING APPROPRIATE REG DOMAIN: JP 6月 20 08:47:18 volumior5 sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up 6月 20 08:47:18 volumior5 sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:18 volumior5 sudo[1254]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:18 volumior5 sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set JP 6月 20 08:47:18 volumior5 sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:18 volumior5 sudo[1256]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:18 volumior5 wireless.js[752]: SUCCESSFULLY SET NEW REGDOMAIN: JP 6月 20 08:47:18 volumior5 wireless.js[752]: Start wireless flow 6月 20 08:47:18 volumior5 wireless.js[752]: Stopped hotspot (if there).. 6月 20 08:47:18 volumior5 sudo[1261]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 6月 20 08:47:18 volumior5 sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:18 volumior5 sudo[1261]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:18 volumior5 sudo[1263]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down 6月 20 08:47:18 volumior5 sudo[1263]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:19 volumior5 dhclient[730]: receive_packet failed on wlan0: Network is down 6月 20 08:47:19 volumior5 sh[659]: receive_packet failed on wlan0: Network is down 6月 20 08:47:19 volumior5 sudo[1263]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:19 volumior5 wireless.js[752]: DHCP IP 6月 20 08:47:19 volumior5 wireless.js[752]: Start ap 6月 20 08:47:19 volumior5 wpa_supplicant[1265]: Successfully initialized wpa_supplicant 6月 20 08:47:19 volumior5 sudo[1266]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd 6月 20 08:47:19 volumior5 sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:19 volumior5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled 6月 20 08:47:19 volumior5 dhcpcd[1267]: dev: loaded udev 6月 20 08:47:19 volumior5 kernel: 8021q: 802.1Q VLAN Support v1.8 6月 20 08:47:19 volumior5 dhcpcd[1267]: wlan0: connected to Access Point `' 6月 20 08:47:19 volumior5 dhcpcd[1267]: no interfaces have a carrier 6月 20 08:47:19 volumior5 dhcpcd[1267]: forked to background, child pid 1302 6月 20 08:47:19 volumior5 dhcpcd[1302]: eth0: waiting for carrier 6月 20 08:47:19 volumior5 dhcpcd[1302]: wlan0: waiting for carrier 6月 20 08:47:19 volumior5 sudo[1266]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:19 volumior5 supervisord[883]: 2025-06-20 08:47:19,787 INFO spawned: 'radiko' with pid 1303 6月 20 08:47:19 volumior5 dhclient[731]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 10 6月 20 08:47:19 volumior5 sh[667]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 10 6月 20 08:47:20 volumior5 dhclient[730]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 10 6月 20 08:47:20 volumior5 sh[659]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 10 6月 20 08:47:20 volumior5 supervisord[883]: 2025-06-20 08:47:20,081 INFO exited: radiko (exit status 1; not expected) 6月 20 08:47:20 volumior5 wireless.js[752]: trying... 6月 20 08:47:20 volumior5 sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:20 volumior5 sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:20 volumior5 sudo[1306]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:21 volumior5 wireless.js[752]: trying... 6月 20 08:47:21 volumior5 sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:21 volumior5 sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:21 volumior5 sudo[1309]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:22 volumior5 supervisord[883]: 2025-06-20 08:47:22,085 INFO spawned: 'radiko' with pid 1311 6月 20 08:47:22 volumior5 supervisord[883]: 2025-06-20 08:47:22,342 INFO exited: radiko (exit status 1; not expected) 6月 20 08:47:22 volumior5 wireless.js[752]: trying... 6月 20 08:47:22 volumior5 sudo[1314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:22 volumior5 sudo[1314]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:22 volumior5 sudo[1314]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:22 volumior5 volumio-time-update[764]: volumio-time-update-util: Fetching time from Volumio... 6月 20 08:47:22 volumior5 volumio-time-update[764]: volumio-time-update-util: Date not found in response 6月 20 08:47:22 volumior5 volumio-time-update[764]: volumio-time-update-util: Retrying in 5 seconds... 6月 20 08:47:23 volumior5 wireless.js[752]: trying... 6月 20 08:47:23 volumior5 sudo[1322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:23 volumior5 sudo[1322]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:23 volumior5 sudo[1322]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:24 volumior5 systemd[1]: NetworkManager-dispatcher.service: Succeeded. 6月 20 08:47:24 volumior5 wireless.js[752]: trying... 6月 20 08:47:24 volumior5 sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:24 volumior5 sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:24 volumior5 sudo[1325]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:25 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:25] [info] asio async_connect error: system:111 (Connection refused) 6月 20 08:47:25 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:25] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) 6月 20 08:47:25 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:25] [error] handle_connect error: Underlying Transport Error 6月 20 08:47:25 volumior5 wpa_supplicant[1286]: wlan0: Trying to associate with SSID 'TP-Link_53CC' 6月 20 08:47:25 volumior5 supervisord[883]: 2025-06-20 08:47:25,346 INFO spawned: 'radiko' with pid 1327 6月 20 08:47:25 volumior5 wireless.js[752]: trying... 6月 20 08:47:25 volumior5 sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:25 volumior5 sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:25 volumior5 sudo[1330]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:25 volumior5 supervisord[883]: 2025-06-20 08:47:25,638 INFO exited: radiko (exit status 1; not expected) 6月 20 08:47:26 volumior5 wireless.js[752]: trying... 6月 20 08:47:26 volumior5 sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:26 volumior5 sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:26 volumior5 sudo[1333]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:26 volumior5 supervisord[883]: 2025-06-20 08:47:26,640 INFO gave up: radiko entered FATAL state, too many start retries too quickly 6月 20 08:47:27 volumior5 wireless.js[752]: trying... 6月 20 08:47:27 volumior5 sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:27 volumior5 sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:27 volumior5 sudo[1336]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:27 volumior5 volumio-time-update[764]: volumio-time-update-util: Fetching time from Volumio... 6月 20 08:47:27 volumior5 volumio-time-update[764]: volumio-time-update-util: Date not found in response 6月 20 08:47:27 volumior5 volumio-time-update[764]: volumio-time-update-util: Retrying in 5 seconds... 6月 20 08:47:28 volumior5 wireless.js[752]: trying... 6月 20 08:47:28 volumior5 sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:28 volumior5 sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:28 volumior5 sudo[1344]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:28 volumior5 wpa_supplicant[1286]: wlan0: Associated with a8:6e:84:98:06:62 6月 20 08:47:28 volumior5 wpa_supplicant[1286]: wlan0: CTRL-EVENT-CONNECTED - Connection to a8:6e:84:98:06:62 completed [id=0 id_str=] 6月 20 08:47:28 volumior5 dhcpcd[1302]: wlan0: carrier acquired 6月 20 08:47:28 volumior5 wpa_supplicant[1286]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 6月 20 08:47:28 volumior5 dhcpcd[1302]: wlan0: connected to Access Point `TP-Link_53CC' 6月 20 08:47:28 volumior5 wpa_supplicant[1286]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP 6月 20 08:47:28 volumior5 dhcpcd[1302]: DUID 00:01:00:01:2e:7d:83:50:2c:cf:67:76:58:29 6月 20 08:47:28 volumior5 dhcpcd[1302]: wlan0: IAID 67:76:58:29 6月 20 08:47:28 volumior5 dhcpcd[1302]: wlan0: adding address fe80::126a:ee41:2794:61ac 6月 20 08:47:28 volumior5 dhcpcd[1302]: ipv6_addaddr1: Permission denied 6月 20 08:47:28 volumior5 dhcpcd[1302]: wlan0: soliciting an IPv6 router 6月 20 08:47:29 volumior5 dhcpcd[1302]: wlan0: soliciting a DHCP lease 6月 20 08:47:29 volumior5 dhcpcd[1302]: wlan0: offered 192.168.178.235 from 192.168.178.1 6月 20 08:47:29 volumior5 dhcpcd[1302]: wlan0: probing address 192.168.178.235/24 6月 20 08:47:29 volumior5 wireless.js[752]: trying... 6月 20 08:47:29 volumior5 sudo[1349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:29 volumior5 sudo[1349]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:29 volumior5 sudo[1349]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:29 volumior5 dhclient[731]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 8 6月 20 08:47:29 volumior5 sh[667]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 8 6月 20 08:47:30 volumior5 wireless.js[752]: trying... 6月 20 08:47:30 volumior5 sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:30 volumior5 sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:30 volumior5 sudo[1352]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:30 volumior5 dhclient[730]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 14 6月 20 08:47:30 volumior5 sh[659]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 14 6月 20 08:47:30 volumior5 dhclient[730]: DHCPOFFER of 192.168.178.236 from 192.168.178.1 6月 20 08:47:30 volumior5 sh[659]: DHCPOFFER of 192.168.178.236 from 192.168.178.1 6月 20 08:47:30 volumior5 sh[659]: DHCPREQUEST for 192.168.178.236 on wlan0 to 255.255.255.255 port 67 6月 20 08:47:30 volumior5 dhclient[730]: DHCPREQUEST for 192.168.178.236 on wlan0 to 255.255.255.255 port 67 6月 20 08:47:30 volumior5 dhclient[730]: DHCPACK of 192.168.178.236 from 192.168.178.1 6月 20 08:47:30 volumior5 sh[659]: DHCPACK of 192.168.178.236 from 192.168.178.1 6月 20 08:47:30 volumior5 avahi-daemon[753]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.236. 6月 20 08:47:30 volumior5 avahi-daemon[753]: New relevant interface wlan0.IPv4 for mDNS. 6月 20 08:47:30 volumior5 avahi-daemon[753]: Registering new address record for 192.168.178.236 on wlan0.IPv4. 6月 20 08:47:30 volumior5 ntpd[904]: ntpd exiting on signal 15 (Terminated) 6月 20 08:47:30 volumior5 systemd[1]: Stopping Network Time Service... 6月 20 08:47:30 volumior5 systemd[1]: ntp.service: Succeeded. 6月 20 08:47:30 volumior5 systemd[1]: Stopped Network Time Service. 6月 20 08:47:30 volumior5 systemd[1]: Starting Network Time Service... 6月 20 08:47:30 volumior5 ntpd[1383]: ntpd 4.2.8p12@1.3728-o (1): Starting 6月 20 08:47:30 volumior5 ntpd[1383]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 6月 20 08:47:30 volumior5 systemd[1]: Started Network Time Service. 6月 20 08:47:30 volumior5 ntpd[1389]: proto: precision = 0.370 usec (-21) 6月 20 08:47:30 volumior5 ntpd[1389]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature 6月 20 08:47:30 volumior5 ntpd[1389]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 6月 20 08:47:30 volumior5 ntpd[1389]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 174 days ago 6月 20 08:47:30 volumior5 ntpd[1389]: Listen and drop on 0 v6wildcard [::]:123 6月 20 08:47:30 volumior5 ntpd[1389]: Listen and drop on 1 v4wildcard 0.0.0.0:123 6月 20 08:47:30 volumior5 ntpd[1389]: Listen normally on 2 lo 127.0.0.1:123 6月 20 08:47:30 volumior5 ntpd[1389]: Listen normally on 3 wlan0 192.168.178.236:123 6月 20 08:47:30 volumior5 ntpd[1389]: Listening on routing socket on fd #20 for interface updates 6月 20 08:47:30 volumior5 ntpd[1389]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:47:30 volumior5 ntpd[1389]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:47:30 volumior5 dhclient[730]: bound to 192.168.178.236 -- renewal in 2859 seconds. 6月 20 08:47:30 volumior5 sh[659]: bound to 192.168.178.236 -- renewal in 2859 seconds. 6月 20 08:47:30 volumior5 sh[659]: wlan0=wlan0 6月 20 08:47:31 volumior5 nmbd[937]: [2025/06/20 08:47:31.193473, 0] ../lib/util/become_daemon.c:138(daemon_ready) 6月 20 08:47:31 volumior5 nmbd[937]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections 6月 20 08:47:31 volumior5 systemd[1]: Started Samba NMB Daemon. 6月 20 08:47:31 volumior5 systemd[1]: Starting Samba Winbind Daemon... 6月 20 08:47:31 volumior5 winbindd[1421]: [2025/06/20 08:47:31.316745, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) 6月 20 08:47:31 volumior5 winbindd[1421]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 6月 20 08:47:31 volumior5 winbindd[1421]: [2025/06/20 08:47:31.353203, 0] ../lib/util/become_daemon.c:138(daemon_ready) 6月 20 08:47:31 volumior5 systemd[1]: Started Samba Winbind Daemon. 6月 20 08:47:31 volumior5 winbindd[1421]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections 6月 20 08:47:31 volumior5 systemd[1]: Starting Samba SMB Daemon... 6月 20 08:47:31 volumior5 wireless.js[752]: trying... 6月 20 08:47:31 volumior5 sudo[1428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r 6月 20 08:47:31 volumior5 sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:31 volumior5 sudo[1428]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:31 volumior5 wireless.js[752]: Connected to: ----TP-Link_53CC 6月 20 08:47:31 volumior5 wireless.js[752]: ---- 6月 20 08:47:31 volumior5 sudo[1431]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 6月 20 08:47:31 volumior5 sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:31 volumior5 sudo[1431]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:31 volumior5 wireless.js[752]: ... joined AP, wlan0 IPv4 is 192.168.178.236, ipV6 is undefined 6月 20 08:47:31 volumior5 wireless.js[752]: It's done! AP 6月 20 08:47:31 volumior5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled 6月 20 08:47:31 volumior5 systemd[1]: Started Wireless Services. 6月 20 08:47:31 volumior5 systemd[1]: Started Volumio Backend Module. 6月 20 08:47:31 volumior5 systemd[1]: Started Volumio Cpu Tweaker. 6月 20 08:47:31 volumior5 volumio-cpu-tweak[1437]: Setting RT Priority for mpd 6月 20 08:47:31 volumior5 volumio-cpu-tweak[1437]: Setting MPD Affinity 6月 20 08:47:31 volumior5 volumio-cpu-tweak[1437]: pid 920's current affinity mask: f 6月 20 08:47:31 volumior5 volumio-cpu-tweak[1437]: pid 920's new affinity mask: 3 6月 20 08:47:31 volumior5 volumio-cpu-tweak[1437]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input 6月 20 08:47:31 volumior5 volumio-cpu-tweak[1437]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative 6月 20 08:47:31 volumior5 systemd[1]: volumio_cpu_tweak.service: Succeeded. 6月 20 08:47:31 volumior5 smbd[1426]: [2025/06/20 08:47:31.629188, 0] ../lib/util/become_daemon.c:138(daemon_ready) 6月 20 08:47:31 volumior5 smbd[1426]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections 6月 20 08:47:31 volumior5 systemd[1]: Started Samba SMB Daemon. 6月 20 08:47:32 volumior5 volumio[1436]: info: ------------------------------------------- 6月 20 08:47:32 volumior5 volumio[1436]: info: ----- Volumio3 ---- 6月 20 08:47:32 volumior5 volumio[1436]: info: ------------------------------------------- 6月 20 08:47:32 volumior5 volumio[1436]: info: ----- System startup ---- 6月 20 08:47:32 volumior5 volumio[1436]: info: ------------------------------------------- 6月 20 08:47:32 volumior5 volumio[1436]: info: MYVOLUMIO Environment detected 6月 20 08:47:32 volumior5 volumio[1436]: info: Plugin folders cleanup 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning into folder /volumio/app/plugins/ 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning category audio_interface 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning category miscellanea 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning category music_service 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning category plugins.json 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning category system_controller 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning category user_interface 6月 20 08:47:32 volumior5 volumio[1436]: info: Scanning into folder /data/plugins/ 6月 20 08:47:32 volumior5 volumio[1436]: info: Plugin folders cleanup completed 6月 20 08:47:32 volumior5 volumio[1436]: info: ------------------------------------------- 6月 20 08:47:32 volumior5 volumio[1436]: info: ----- Core plugins startup ---- 6月 20 08:47:32 volumior5 volumio[1436]: info: ------------------------------------------- 6月 20 08:47:32 volumior5 volumio[1436]: info: Loading plugins from folder /volumio/app/plugins/ 6月 20 08:47:32 volumior5 volumio[1436]: info: Adding plugin upnp to MyMusic Plugins 6月 20 08:47:32 volumior5 volumio[1436]: info: Adding plugin airplay_emulation to MyMusic Plugins 6月 20 08:47:32 volumior5 volumio[1436]: info: Adding plugin upnp_browser to MyMusic Plugins 6月 20 08:47:32 volumior5 volumio[1436]: info: Loading plugins from folder /data/plugins/ 6月 20 08:47:32 volumior5 volumio[1436]: info: Loading plugin "system"... 6月 20 08:47:32 volumior5 volumio[1436]: info: Loading plugin "appearance"... 6月 20 08:47:32 volumior5 volumio-time-update[764]: volumio-time-update-util: Fetching time from Volumio... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "network"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Refreshing Cached IP Addresses 6月 20 08:47:33 volumior5 sudo[1478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 6月 20 08:47:33 volumior5 sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:33 volumior5 sudo[1478]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:33 volumior5 sudo[1480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 6月 20 08:47:33 volumior5 sudo[1480]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:33 volumior5 sudo[1480]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "services"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "alsa_controller"... 6月 20 08:47:33 volumior5 sudo[1489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan 6月 20 08:47:33 volumior5 sudo[1489]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:33 volumior5 dhcpcd[1302]: wlan0: leased 192.168.178.235 for 7200 seconds 6月 20 08:47:33 volumior5 avahi-daemon[753]: Registering new address record for 192.168.178.235 on wlan0.IPv4. 6月 20 08:47:33 volumior5 dhcpcd[1302]: wlan0: adding route to 192.168.178.0/24 6月 20 08:47:33 volumior5 dhcpcd[1302]: wlan0: adding default route via 192.168.178.1 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "wizard"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "networkfs"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Starting Udev Watcher for removable devices 6月 20 08:47:33 volumior5 ntpd[1389]: ntpd exiting on signal 15 (Terminated) 6月 20 08:47:33 volumior5 systemd[1]: Stopping Network Time Service... 6月 20 08:47:33 volumior5 ntpd[1389]: 23.81.40.154 local addr 192.168.178.236 -> 6月 20 08:47:33 volumior5 systemd[1]: ntp.service: Succeeded. 6月 20 08:47:33 volumior5 systemd[1]: Stopped Network Time Service. 6月 20 08:47:33 volumior5 volumio[1436]: info: Ignoring mount for partition: boot 6月 20 08:47:33 volumior5 volumio[1436]: info: Ignoring mount for partition: volumio 6月 20 08:47:33 volumior5 volumio[1436]: info: Ignoring mount for partition: volumio_data 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "volumio_command_line_client"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "upnp"... 6月 20 08:47:33 volumior5 volumio[1436]: info: [1750376853333] Starting Upmpd Daemon 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "my_music"... 6月 20 08:47:33 volumior5 systemd[1]: Starting Network Time Service... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "mpd"... 6月 20 08:47:33 volumior5 ntpd[1531]: ntpd 4.2.8p12@1.3728-o (1): Starting 6月 20 08:47:33 volumior5 ntpd[1531]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 6月 20 08:47:33 volumior5 systemd[1]: Started Network Time Service. 6月 20 08:47:33 volumior5 ntpd[1537]: proto: precision = 0.370 usec (-21) 6月 20 08:47:33 volumior5 ntpd[1537]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature 6月 20 08:47:33 volumior5 ntpd[1537]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 6月 20 08:47:33 volumior5 ntpd[1537]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 174 days ago 6月 20 08:47:33 volumior5 ntpd[1537]: Listen and drop on 0 v6wildcard [::]:123 6月 20 08:47:33 volumior5 ntpd[1537]: Listen and drop on 1 v4wildcard 0.0.0.0:123 6月 20 08:47:33 volumior5 ntpd[1537]: Listen normally on 2 lo 127.0.0.1:123 6月 20 08:47:33 volumior5 ntpd[1537]: Listen normally on 3 wlan0 192.168.178.236:123 6月 20 08:47:33 volumior5 ntpd[1537]: Listen normally on 4 wlan0 192.168.178.235:123 6月 20 08:47:33 volumior5 ntpd[1537]: Listening on routing socket on fd #21 for interface updates 6月 20 08:47:33 volumior5 ntpd[1537]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:47:33 volumior5 ntpd[1537]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:47:33 volumior5 dhcpcd[1302]: wlan0: pid 1302 deleted route to 192.168.178.0/24 6月 20 08:47:33 volumior5 dhcpcd[1302]: wlan0: pid 1302 deleted default route via 192.168.178.1 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "upnp_browser"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "alarm-clock"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "airplay_emulation"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Starting Shairport Sync 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "last_100"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "webradio"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "i2s_dacs"... 6月 20 08:47:33 volumior5 volumio[1436]: info: I2S DAC not set, start Auto-detection 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "volumiodiscovery"... 6月 20 08:47:33 volumior5 volumio[1436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. 6月 20 08:47:33 volumior5 node[1436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. 6月 20 08:47:33 volumior5 node[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! 6月 20 08:47:33 volumior5 volumio[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! 6月 20 08:47:33 volumior5 volumio[1436]: *** WARNING *** For more information see 6月 20 08:47:33 volumior5 volumio[1436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. 6月 20 08:47:33 volumior5 volumio[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! 6月 20 08:47:33 volumior5 volumio[1436]: *** WARNING *** For more information see 6月 20 08:47:33 volumior5 node[1436]: *** WARNING *** For more information see 6月 20 08:47:33 volumior5 node[1436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. 6月 20 08:47:33 volumior5 node[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! 6月 20 08:47:33 volumior5 node[1436]: *** WARNING *** For more information see 6月 20 08:47:33 volumior5 volumio[1436]: info: Applying required configuration parameters for plugin volumiodiscovery 6月 20 08:47:33 volumior5 volumio[1436]: info: Discovery: Started advertising with name: VolumioR5 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "outputs"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "albumart"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Plugin example_plugin is not enabled 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "inputs"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "updater_comm"... 6月 20 08:47:33 volumior5 volumio[1436]: Forking 3 albumart workers 6月 20 08:47:33 volumior5 volumio[1436]: info: Plugin mpdemulation is not enabled 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "rest_api"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading plugin "websocket"... 6月 20 08:47:33 volumior5 volumio[1436]: info: Starting Socket.io Server version 2.3.0 6月 20 08:47:33 volumior5 volumio[1436]: info: Loading i18n strings for locale ja 6月 20 08:47:33 volumior5 volumio[1436]: Updating browse sources language 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::initPlayerControls 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 6月 20 08:47:33 volumior5 volumio[1436]: Express server listening on port 3000 6月 20 08:47:33 volumior5 volumio[1436]: [Metrics] WebUI: 1s 953.82ms 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreStateMachine::resetVolumioState 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreStateMachine::getcurrentVolume 6月 20 08:47:33 volumior5 volumio[1436]: info: CoreCommandRouter::volumioRetrievevolume 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: Volumio Network Manager: Network status updated: 2 6月 20 08:47:34 volumior5 volumio[1436]: Starting albumart workers 6月 20 08:47:34 volumior5 volumio[1436]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 6月 20 08:47:34 volumior5 volumio[1436]: Starting albumart workers 6月 20 08:47:34 volumior5 volumio[1436]: info: Reloading queue from file 6月 20 08:47:34 volumior5 volumio[1436]: Starting albumart workers 6月 20 08:47:34 volumior5 volumio[1436]: info: Setting Device type: Raspberry PI 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreStateMachine::setRepeat null single undefined 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreStateMachine::pushState 6月 20 08:47:34 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioPushState 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreStateMachine::setRandom null 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreStateMachine::pushState 6月 20 08:47:34 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioPushState 6月 20 08:47:34 volumior5 volumio[1436]: info: VolumeController:: Volume=undefined Mute =false 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreStateMachine::pushState 6月 20 08:47:34 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioPushState 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreStateMachine::updateTrackBlock 6月 20 08:47:34 volumior5 volumio[1436]: info: CorePlayQueue::getTrackBlock 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioRetrievevolume 6月 20 08:47:34 volumior5 volumio[1436]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb 6月 20 08:47:34 volumior5 volumio[1436]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b04170 6月 20 08:47:34 volumior5 volumio[1436]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI 6月 20 08:47:34 volumior5 volumio[1436]: info: Completed loading Core Plugins 6月 20 08:47:34 volumior5 volumio[1436]: info: Preparing to generate the ALSA configuration file 6月 20 08:47:34 volumior5 volumio[1436]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 6月 20 08:47:34 volumior5 volumio[1436]: info: Asound.conf file unchanged, so no further update is needed 6月 20 08:47:34 volumior5 volumio[1436]: info: Output device has changed, restarting MPD 6月 20 08:47:34 volumior5 volumio[1436]: info: Output device has changed, restarting Shairport Sync 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:34 volumior5 sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf 6月 20 08:47:34 volumior5 sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 sudo[1586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service 6月 20 08:47:34 volumior5 sudo[1584]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 sudo[1586]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 volumio[1436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 6月 20 08:47:34 volumior5 volumio[1436]: info: ___________ START PLUGINS ___________ 6月 20 08:47:34 volumior5 volumio[1436]: info: ControllerMpd::onStart: Initializing MPD 6月 20 08:47:34 volumior5 volumio[1436]: info: Creating MPD Configuration file 6月 20 08:47:34 volumior5 systemd[1]: Stopping Music Player Daemon... 6月 20 08:47:34 volumior5 sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf 6月 20 08:47:34 volumior5 sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] 6月 20 08:47:34 volumior5 volumio[1436]: info: [1750376854193] CoreMusicLibrary::Adding element DLNAサーバー 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 6月 20 08:47:34 volumior5 sudo[1593]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 sudo[1596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service 6月 20 08:47:34 volumior5 sudo[1596]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] 6月 20 08:47:34 volumior5 volumio[1436]: info: [1750376854258] CoreMusicLibrary::Adding element Last_100 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] 6月 20 08:47:34 volumior5 volumio[1436]: info: [1750376854258] CoreMusicLibrary::Adding element Webradio 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 6月 20 08:47:34 volumior5 volumio[1436]: info: Initializing BBC Radios 6月 20 08:47:34 volumior5 systemd[1]: mpd.service: Succeeded. 6月 20 08:47:34 volumior5 systemd[1]: Stopped Music Player Daemon. 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: Volumio Calling Home 6月 20 08:47:34 volumior5 systemd[1]: Starting Music Player Daemon... 6月 20 08:47:34 volumior5 sudo[1630]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log 6月 20 08:47:34 volumior5 sudo[1630]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 sudo[1630]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 volumio[1436]: info: MPD Permissions set 6月 20 08:47:34 volumior5 volumio[1436]: info: MPD Permissions set 6月 20 08:47:34 volumior5 volumio[1436]: info: VolumeController:: Volume=undefined Mute =false 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreStateMachine::pushState 6月 20 08:47:34 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioPushState 6月 20 08:47:34 volumior5 volumio[1436]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:47:34 volumior5 volumio[1436]: info: Starting Shairport Sync 6月 20 08:47:34 volumior5 volumio[1436]: info: Starting Shairport Sync 6月 20 08:47:34 volumior5 volumio[1436]: info: Starting Shairport Sync 6月 20 08:47:34 volumior5 sudo[1653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync 6月 20 08:47:34 volumior5 sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 sudo[1655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync 6月 20 08:47:34 volumior5 sudo[1655]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync 6月 20 08:47:34 volumior5 sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:34 volumior5 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... 6月 20 08:47:34 volumior5 systemd[1]: shairport-sync.service: Succeeded. 6月 20 08:47:34 volumior5 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. 6月 20 08:47:34 volumior5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. 6月 20 08:47:34 volumior5 sudo[1653]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 sudo[1655]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 volumio[1436]: info: Shairport-Sync Started 6月 20 08:47:34 volumior5 volumio[1436]: Error adding Membership: Error: addMembership EINVAL 6月 20 08:47:34 volumior5 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... 6月 20 08:47:34 volumior5 volumio[1436]: info: Shairport-Sync Started 6月 20 08:47:34 volumior5 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM 6月 20 08:47:34 volumior5 systemd[1]: shairport-sync.service: Succeeded. 6月 20 08:47:34 volumior5 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. 6月 20 08:47:34 volumior5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. 6月 20 08:47:34 volumior5 sudo[1659]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 volumio[1436]: info: Shairport-Sync Started 6月 20 08:47:34 volumior5 ntpd[1537]: Soliciting pool server 202.181.103.212 6月 20 08:47:34 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:34 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:34 volumior5 mpd[1643]: Jun 20 08:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg 6月 20 08:47:34 volumior5 systemd[1]: Started Music Player Daemon. 6月 20 08:47:34 volumior5 sudo[1586]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 sudo[1596]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 volumio[1436]: info: Completed starting Core Plugins 6月 20 08:47:34 volumior5 volumio[1436]: info: ------------------------------------------- 6月 20 08:47:34 volumior5 volumio[1436]: info: ----- MyVolumio plugins startup ---- 6月 20 08:47:34 volumior5 volumio[1436]: info: ------------------------------------------- 6月 20 08:47:34 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Fetching plans data.... 6月 20 08:47:34 volumior5 volumio[1436]: error: MPD error: The expression evaluated to a falsy value: 6月 20 08:47:34 volumior5 volumio[1436]: assert.ok(self.idling) 6月 20 08:47:34 volumior5 volumio[1436]: error: The expression evaluated to a falsy value: 6月 20 08:47:34 volumior5 volumio[1436]: assert.ok(self.idling) 6月 20 08:47:34 volumior5 volumio[1436]: info: MPD running with PID1643 6月 20 08:47:34 volumior5 volumio[1436]: ,establishing connection 6月 20 08:47:34 volumior5 volumio[1436]: error: updateQueue error: null 6月 20 08:47:34 volumior5 volumio[1436]: error: updateQueue error: null 6月 20 08:47:35 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:35] [connect] Successful connection 6月 20 08:47:35 volumior5 volumio-remote-updater[758]: [2025-06-20 08:47:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750376855 101 6月 20 08:47:35 volumior5 volumio[1436]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 6月 20 08:47:35 volumior5 volumio[1436]: info: Discovery: adding ba393bc6-c681-4508-ab4e-97d7ef9a4493 6月 20 08:47:35 volumior5 volumio[1436]: info: Discovery: Found device VolumioR5 6月 20 08:47:35 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:35 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:35 volumior5 volumio[1436]: info: Volumio called home 6月 20 08:47:35 volumior5 ntpd[1537]: Soliciting pool server 162.159.200.123 6月 20 08:47:35 volumior5 volumio-time-update[764]: volumio-time-update-util: Setting system time to: 2025-06-20 08:47:34 6月 20 08:47:35 volumior5 sudo[1670]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-20 08:47:34 6月 20 08:47:35 volumior5 sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:35 volumior5 dbus-daemon[754]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=1671 comm="timedatectl set-time 2025-06-20 08:47:34 ") 6月 20 08:47:35 volumior5 systemd[1]: Starting Time & Date Service... 6月 20 08:47:35 volumior5 dbus-daemon[754]: [system] Successfully activated service 'org.freedesktop.timedate1' 6月 20 08:47:35 volumior5 systemd[1]: Started Time & Date Service. 6月 20 08:47:34 volumior5 systemd-timedated[1672]: Changed local time to Fri Jun 20 08:47:34 2025 6月 20 08:47:34 volumior5 sudo[1670]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:34 volumior5 volumio-time-update[764]: volumio-time-update-util: System time updated successfully. 6月 20 08:47:34 volumior5 systemd[1]: Started Volumio Time Update Utility. 6月 20 08:47:34 volumior5 systemd[1]: Reached target Multi-User System. 6月 20 08:47:34 volumior5 systemd[1]: Reached target Graphical Interface. 6月 20 08:47:34 volumior5 systemd[1]: Starting Update UTMP about System Runlevel Changes... 6月 20 08:47:34 volumior5 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. 6月 20 08:47:34 volumior5 systemd[1]: Started Update UTMP about System Runlevel Changes. 6月 20 08:47:34 volumior5 systemd[1]: Startup finished in 11.943s (kernel) + 26.601s (userspace) = 38.544s. 6月 20 08:47:34 volumior5 ntpd[1537]: Soliciting pool server 167.179.119.205 6月 20 08:47:34 volumior5 ntpd[1537]: Soliciting pool server 133.130.121.141 6月 20 08:47:34 volumior5 ntpd[1537]: Soliciting pool server 162.159.200.1 6月 20 08:47:35 volumior5 sudo[1489]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:35 volumior5 ntpd[1537]: Soliciting pool server 23.81.40.154 6月 20 08:47:35 volumior5 ntpd[1537]: Soliciting pool server 129.250.35.250 6月 20 08:47:35 volumior5 ntpd[1537]: Soliciting pool server 194.0.5.123 6月 20 08:47:36 volumior5 ntpd[1537]: Soliciting pool server 172.237.12.44 6月 20 08:47:36 volumior5 ntpd[1537]: Soliciting pool server 103.131.151.20 6月 20 08:47:36 volumior5 ntpd[1537]: Soliciting pool server 129.250.35.251 6月 20 08:47:36 volumior5 ntpd[1537]: Soliciting pool server 103.131.151.30 6月 20 08:47:36 volumior5 ntpd[1537]: Soliciting pool server 64:ff9b::a29f:c87b 6月 20 08:47:37 volumior5 ntpd[1537]: Soliciting pool server 45.77.20.103 6月 20 08:47:37 volumior5 ntpd[1537]: Soliciting pool server 108.160.132.224 6月 20 08:47:37 volumior5 ntpd[1537]: Soliciting pool server 64:ff9b::8582:798d 6月 20 08:47:37 volumior5 dhclient[731]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 14 6月 20 08:47:37 volumior5 sh[667]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 14 6月 20 08:47:37 volumior5 volumio[1436]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory 6月 20 08:47:38 volumior5 ntpd[1537]: Soliciting pool server 64.176.59.83 6月 20 08:47:38 volumior5 ntpd[1537]: Soliciting pool server 18.180.64.47 6月 20 08:47:39 volumior5 systemd[1]: systemd-fsckd.service: Succeeded. 6月 20 08:47:39 volumior5 ntpd[1537]: Soliciting pool server 64:ff9b::aced:c2c 6月 20 08:47:39 volumior5 ntpd[1537]: Soliciting pool server 2400:8902::f03c:91ff:fe50:f5f0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:41 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:41 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:41 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:41 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:41 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:41 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:41 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:41 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:41 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:41 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:41 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:41 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:41 volumior5 volumio[1436]: verbose: New Socket.io Connection to 192.168.178.236:3000 from 192.168.178.227 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:41 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard 6月 20 08:47:41 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard 6月 20 08:47:41 volumior5 sudo[1694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 6月 20 08:47:41 volumior5 sudo[1694]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:41 volumior5 sudo[1694]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:41 volumior5 sudo[1696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 6月 20 08:47:41 volumior5 sudo[1696]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:41 volumior5 sudo[1696]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:41 volumior5 sudo[1700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service 6月 20 08:47:41 volumior5 sudo[1700]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:41 volumior5 systemd[1]: Started UPnP Renderer front-end to MPD. 6月 20 08:47:41 volumior5 sudo[1700]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:41 volumior5 volumio[1436]: info: Upmpdcli Daemon Started 6月 20 08:47:41 volumior5 volumio[1702]: Generating RSA private key, 4096 bit long modulus (2 primes) 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b383fce3 does not match aorg 0000000000.00000000 from server@129.250.35.250 xmt 0xebff201f.15f10aa9 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b385023d does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xebff201f.15a7f3f8 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b380bc3a does not match aorg 0000000000.00000000 from server@64.176.59.83 xmt 0xebff201f.15e48b94 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b37bf75c does not match aorg 0000000000.00000000 from server@18.180.64.47 xmt 0xebff201f.1533c60b 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b381e8a4 does not match aorg 0000000000.00000000 from server@45.77.20.103 xmt 0xebff201f.151a52e8 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b3836a77 does not match aorg 0000000000.00000000 from server@194.0.5.123 xmt 0xebff201f.171d2a28 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b382c0ed does not match aorg 0000000000.00000000 from server@103.131.151.30 xmt 0xebff201f.178f57f7 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b385900f does not match aorg 0000000000.00000000 from server@167.179.119.205 xmt 0xebff201f.5310e5ca 6月 20 08:47:43 volumior5 ntpd[1537]: receive: Unexpected origin timestamp 0xebff201d.b386229f does not match aorg 0000000000.00000000 from server@202.181.103.212 xmt 0xebff201f.5293dd84 6月 20 08:47:43 volumior5 systemd[1]: systemd-hostnamed.service: Succeeded. 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso 6月 20 08:47:43 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso 6月 20 08:47:43 volumior5 volumio[1436]: info: Adding plugin bluetooth to MyMusic Plugins 6月 20 08:47:43 volumior5 volumio[1436]: info: Adding plugin multiroom to MyMusic Plugins 6月 20 08:47:43 volumior5 volumio[1436]: info: Adding plugin metavolumio to MyMusic Plugins 6月 20 08:47:43 volumior5 volumio[1436]: info: Adding plugin cd_controller to MyMusic Plugins 6月 20 08:47:44 volumior5 volumio[1436]: info: Adding plugin qobuzconnect to MyMusic Plugins 6月 20 08:47:44 volumior5 volumio[1436]: info: Adding plugin smart_inputs to MyMusic Plugins 6月 20 08:47:44 volumior5 volumio[1436]: info: Adding plugin tidalconnect to MyMusic Plugins 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio 6月 20 08:47:44 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:44 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:44 volumior5 volumio[1436]: info: Starting MyVolumio Remote Streaming Endpoints 6月 20 08:47:44 volumior5 volumio[1436]: info: MyVolumio login type: Token 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... 6月 20 08:47:44 volumior5 volumio[1436]: info: Starting Streaming Service Transparent Proxy 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services 6月 20 08:47:44 volumior5 volumio[1436]: info: Streaming services startup 6月 20 08:47:44 volumior5 volumio[1436]: info: Starting Streaming Daemon 6月 20 08:47:44 volumior5 sudo[1728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service 6月 20 08:47:44 volumior5 sudo[1728]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:44 volumior5 volumio[1436]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started 6月 20 08:47:44 volumior5 sudo[1728]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:44 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:44 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:44 volumior5 volumio[1436]: error: Cannot start Volumio Streaming Daemon 6月 20 08:47:44 volumior5 volumio[1436]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service 6月 20 08:47:44 volumior5 volumio[1436]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. 6月 20 08:47:44 volumior5 volumio[1436]: STREAMING PROXY: Starting server on port 3245 6月 20 08:47:44 volumior5 volumio[1436]: Node JS runtime: 14 6月 20 08:47:45 volumior5 sudo[1736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 6月 20 08:47:45 volumior5 sudo[1736]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:45 volumior5 sudo[1736]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:45 volumior5 sudo[1738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 6月 20 08:47:45 volumior5 sudo[1738]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:45 volumior5 sudo[1738]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:45 volumior5 volumio[1436]: verbose: New Socket.io Connection to 192.168.178.236 from 192.168.178.227 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 4 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled 6月 20 08:47:45 volumior5 sudo[1742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 6月 20 08:47:45 volumior5 sudo[1742]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:45 volumior5 sudo[1742]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:45 volumior5 sudo[1744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 6月 20 08:47:45 volumior5 sudo[1744]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:45 volumior5 sudo[1744]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:45 volumior5 volumio[1436]: verbose: New Socket.io Connection to 192.168.178.236 from 192.168.178.227 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 5 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetVisibleSources 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:45 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom 6月 20 08:47:45 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:45 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:45 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:45 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:45 volumior5 volumio[1436]: info: Listing playlists 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache 6月 20 08:47:45 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache 6月 20 08:47:45 volumior5 volumio[1436]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN 6月 20 08:47:46 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:46 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:46 volumior5 volumio[1436]: info: MyVolumio token set successfully 6月 20 08:47:46 volumior5 volumio[1436]: info: MYVOLUMIO: Adding device 6月 20 08:47:46 volumior5 volumio[1436]: info: MYVOLUMIO: Evaluating Server 6月 20 08:47:47 volumior5 volumio[1436]: info: MyVolumio status changed 6月 20 08:47:47 volumior5 volumio[1436]: info: Streaming services startup 6月 20 08:47:47 volumior5 volumio[1436]: info: Starting Streaming Daemon 6月 20 08:47:47 volumior5 volumio[1436]: info: Removing browser output: myVolumio user plan is not superstar 6月 20 08:47:47 volumior5 volumio[1436]: info: Removing audio output: 6月 20 08:47:47 volumior5 volumio[1436]: info: Stoppping Tunnel 1 6月 20 08:47:47 volumior5 sudo[1765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service 6月 20 08:47:47 volumior5 sudo[1765]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:47 volumior5 sudo[1768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service 6月 20 08:47:47 volumior5 sudo[1768]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:47:47 volumior5 sudo[1765]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:47 volumior5 sudo[1768]: pam_unix(sudo:session): session closed for user root 6月 20 08:47:47 volumior5 volumio[1436]: error: Cannot start Volumio Streaming Daemon 6月 20 08:47:47 volumior5 volumio[1436]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service 6月 20 08:47:47 volumior5 volumio[1436]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. 6月 20 08:47:47 volumior5 volumio[1436]: info: Remote SSH Stopped 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard 6月 20 08:47:47 volumior5 volumio[1436]: info: Setting Geolocation for MyVolumio to as1 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:47 volumior5 volumio[1702]: .............................................................................................++++ 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus 6月 20 08:47:47 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:47 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:47 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:47 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken 6月 20 08:47:47 volumior5 volumio[1436]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} 6月 20 08:47:48 volumior5 volumio[1702]: ..............++++ 6月 20 08:47:48 volumior5 volumio[1702]: e is 65537 (0x010001) 6月 20 08:47:48 volumior5 volumio[1702]: writing RSA key 6月 20 08:47:48 volumior5 volumio[1436]: info: Updating MyVolumio device info 6月 20 08:47:48 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:48 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:48 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:49 volumior5 volumio[1436]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} 6月 20 08:47:51 volumior5 volumio[1436]: info: MYVOLUMIO: Adding device 6月 20 08:47:51 volumior5 volumio[1436]: info: MYVOLUMIO: Evaluating Server 6月 20 08:47:52 volumior5 volumio[1436]: info: Setting Geolocation for MyVolumio to as1 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus 6月 20 08:47:52 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:47:52 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:52 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:47:52 volumior5 dhclient[731]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 21 6月 20 08:47:52 volumior5 sh[667]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 21 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetQueue 6月 20 08:47:52 volumior5 volumio[1436]: info: CoreStateMachine::getQueue 6月 20 08:47:52 volumior5 volumio[1436]: info: CorePlayQueue::getQueue 6月 20 08:47:53 volumior5 volumio[1436]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} 6月 20 08:47:53 volumior5 volumio[1436]: info: Updating MyVolumio device info 6月 20 08:47:53 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:53 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:53 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:47:54 volumior5 volumio[1436]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} 6月 20 08:47:55 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted 6月 20 08:47:58 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:58 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:47:59 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings 6月 20 08:47:59 volumior5 volumio[1436]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 6月 20 08:47:59 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:47:59 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:03 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 6月 20 08:48:03 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:48:03 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled 6月 20 08:48:04 volumior5 volumio-remote-updater[758]: No test mode 6月 20 08:48:04 volumior5 volumio-remote-updater[758]: No alpha test mode 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetBrowseSources 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 6月 20 08:48:04 volumior5 volumio[1436]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache 6月 20 08:48:04 volumior5 volumio[1436]: error: MyVolumio Plugin failed to authenticate in a timely fashion 6月 20 08:48:04 volumior5 volumio[1436]: info: Completed starting MyVolumio Plugin 6月 20 08:48:04 volumior5 volumio[1436]: [Metrics] CommandRouter: 32s 787.74ms 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::volumiosetStartupVolume 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::Close All Modals sent 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::Close All Modals sent 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings 6月 20 08:48:04 volumior5 volumio[1436]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates 6月 20 08:48:04 volumior5 volumio[1436]: info: Received Get System Version 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 6月 20 08:48:04 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:48:04 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:04 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:04 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:48:05 volumior5 systemd[1]: systemd-timedated.service: Succeeded. 6月 20 08:48:05 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable 6月 20 08:48:05 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus 6月 20 08:48:05 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect 6月 20 08:48:05 volumior5 volumio[1436]: info: Version has changed, forcing UI Reload 6月 20 08:48:05 volumior5 volumio[1436]: info: CoreCommandRouter::Reload Ui 6月 20 08:48:06 volumior5 sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 6月 20 08:48:06 volumior5 sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:48:06 volumior5 sudo[1841]: pam_unix(sudo:session): session closed for user root 6月 20 08:48:06 volumior5 sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 6月 20 08:48:06 volumior5 sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0) 6月 20 08:48:06 volumior5 sudo[1844]: pam_unix(sudo:session): session closed for user root 6月 20 08:48:06 volumior5 volumio[1436]: verbose: New Socket.io Connection to 192.168.178.236 from 192.168.178.227 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetVisibleSources 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:06 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom 6月 20 08:48:06 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:48:06 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:06 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:06 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:06 volumior5 volumio[1436]: info: Listing playlists 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:48:06 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:06 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:06 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:48:07 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:07 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:07 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard 6月 20 08:48:08 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus 6月 20 08:48:08 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:48:08 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:48:08 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:48:08 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:48:08 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:08 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:08 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:48:09 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus 6月 20 08:48:09 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:48:09 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:48:09 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:48:09 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:48:09 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:09 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:09 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:48:11 volumior5 volumio[1436]: info: BOOT COMPLETED 6月 20 08:48:12 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetQueue 6月 20 08:48:12 volumior5 volumio[1436]: info: CoreStateMachine::getQueue 6月 20 08:48:12 volumior5 volumio[1436]: info: CorePlayQueue::getQueue 6月 20 08:48:13 volumior5 dhclient[731]: No DHCPOFFERS received. 6月 20 08:48:13 volumior5 sh[667]: No DHCPOFFERS received. 6月 20 08:48:13 volumior5 sh[667]: No working leases in persistent database - sleeping. 6月 20 08:48:13 volumior5 dhclient[731]: No working leases in persistent database - sleeping. 6月 20 08:48:13 volumior5 systemd[1]: Stopping Network Time Service... 6月 20 08:48:13 volumior5 ntpd[1537]: ntpd exiting on signal 15 (Terminated) 6月 20 08:48:13 volumior5 ntpd[1537]: 202.181.103.212 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 162.159.200.123 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 167.179.119.205 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 162.159.200.1 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 133.130.121.141 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 129.250.35.250 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 23.81.40.154 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 194.0.5.123 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 172.237.12.44 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 systemd[1]: ntp.service: Succeeded. 6月 20 08:48:13 volumior5 ntpd[1537]: 129.250.35.251 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 103.131.151.20 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 103.131.151.30 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 108.160.132.224 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 45.77.20.103 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 64.176.59.83 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 ntpd[1537]: 18.180.64.47 local addr 192.168.178.235 -> 6月 20 08:48:13 volumior5 systemd[1]: Stopped Network Time Service. 6月 20 08:48:13 volumior5 systemd[1]: Starting Network Time Service... 6月 20 08:48:13 volumior5 ntpd[1917]: ntpd 4.2.8p12@1.3728-o (1): Starting 6月 20 08:48:13 volumior5 ntpd[1917]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 6月 20 08:48:13 volumior5 systemd[1]: Started Network Time Service. 6月 20 08:48:13 volumior5 ntpd[1923]: proto: precision = 0.500 usec (-21) 6月 20 08:48:13 volumior5 ntpd[1923]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature 6月 20 08:48:13 volumior5 ntpd[1923]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 6月 20 08:48:13 volumior5 ntpd[1923]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 174 days ago 6月 20 08:48:13 volumior5 ntpd[1923]: Listen and drop on 0 v6wildcard [::]:123 6月 20 08:48:13 volumior5 ntpd[1923]: Listen and drop on 1 v4wildcard 0.0.0.0:123 6月 20 08:48:13 volumior5 ntpd[1923]: Listen normally on 2 lo 127.0.0.1:123 6月 20 08:48:13 volumior5 ntpd[1923]: Listen normally on 3 wlan0 192.168.178.236:123 6月 20 08:48:13 volumior5 ntpd[1923]: Listen normally on 4 wlan0 192.168.178.235:123 6月 20 08:48:13 volumior5 ntpd[1923]: Listening on routing socket on fd #21 for interface updates 6月 20 08:48:13 volumior5 ntpd[1923]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:48:13 volumior5 ntpd[1923]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized 6月 20 08:48:13 volumior5 sh[667]: eth0=eth0 6月 20 08:48:14 volumior5 ntpd[1923]: Soliciting pool server 202.181.103.212 6月 20 08:48:15 volumior5 ntpd[1923]: Soliciting pool server 129.250.35.250 6月 20 08:48:15 volumior5 ntpd[1923]: Soliciting pool server 167.179.119.205 6月 20 08:48:16 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted 6月 20 08:48:16 volumior5 ntpd[1923]: Soliciting pool server 133.130.121.141 6月 20 08:48:16 volumior5 ntpd[1923]: Soliciting pool server 162.159.200.123 6月 20 08:48:17 volumior5 ntpd[1923]: Soliciting pool server 194.0.5.123 6月 20 08:48:17 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri 6月 20 08:48:17 volumior5 volumio[1436]: info: Preload queue cleared 6月 20 08:48:17 volumior5 ntpd[1923]: Soliciting pool server 129.250.35.251 6月 20 08:48:17 volumior5 ntpd[1923]: Soliciting pool server 23.81.40.154 6月 20 08:48:17 volumior5 ntpd[1923]: Soliciting pool server 162.159.200.1 6月 20 08:48:17 volumior5 ntpd[1923]: Soliciting pool server 172.237.12.44 6月 20 08:48:18 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri 6月 20 08:48:18 volumior5 volumio[1436]: info: Preload queue cleared 6月 20 08:48:18 volumior5 ntpd[1923]: Soliciting pool server 64.176.59.83 6月 20 08:48:18 volumior5 ntpd[1923]: Soliciting pool server 108.160.132.224 6月 20 08:48:18 volumior5 ntpd[1923]: Soliciting pool server 103.131.151.30 6月 20 08:48:18 volumior5 ntpd[1923]: Soliciting pool server 64:ff9b::8ba2:512d 6月 20 08:48:19 volumior5 ntpd[1923]: Soliciting pool server 103.131.151.20 6月 20 08:48:19 volumior5 ntpd[1923]: Soliciting pool server 18.180.64.47 6月 20 08:48:19 volumior5 ntpd[1923]: Soliciting pool server 64:ff9b::1751:289a 6月 20 08:48:20 volumior5 ntpd[1923]: Soliciting pool server 45.77.20.103 6月 20 08:48:20 volumior5 ntpd[1923]: Soliciting pool server 240b:4009:25a:1801:0:cd59:120f:f74b 6月 20 08:48:21 volumior5 ntpd[1923]: Soliciting pool server 64:ff9b::aced:c2c 6月 20 08:48:24 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings 6月 20 08:48:24 volumior5 volumio[1436]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined 6月 20 08:48:24 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates 6月 20 08:48:24 volumior5 volumio[1436]: info: Received Get System Version 6月 20 08:48:24 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion 6月 20 08:48:24 volumior5 volumio[1436]: info: Received Get System Info 6月 20 08:48:24 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo 6月 20 08:48:24 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice 6月 20 08:48:24 volumior5 volumio[1436]: info: Discovery: Getting this device information 6月 20 08:48:24 volumior5 volumio[1436]: info: CoreCommandRouter::volumioGetState 6月 20 08:48:24 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:24 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses 6月 20 08:48:25 volumior5 volumio[1436]: info: Preload queue cleared 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::ClearQueue 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::stop 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined 6月 20 08:48:25 volumior5 volumio[1436]: info: CorePlayQueue::clearPlayQueue 6月 20 08:48:25 volumior5 volumio[1436]: info: CorePlayQueue::saveQueue 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreCommandRouter::volumioPushQueue 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::addQueueItems 6月 20 08:48:25 volumior5 volumio[1436]: info: CorePlayQueue::addQueueItems 6月 20 08:48:25 volumior5 volumio[1436]: info: Preload queue cleared 6月 20 08:48:25 volumior5 volumio[1436]: info: Adding Item to queue: upnp/folder/http://192.168.178.106:8200/ctl/ContentDir@1 6月 20 08:48:25 volumior5 volumio[1436]: info: Exploding uri upnp/folder/http://192.168.178.106:8200/ctl/ContentDir@1 in service upnp_browser 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreCommandRouter::volumioPushQueue 6月 20 08:48:25 volumior5 volumio[1436]: info: CorePlayQueue::saveQueue 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::updateTrackBlock 6月 20 08:48:25 volumior5 volumio[1436]: info: CorePlayQueue::getTrackBlock 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreCommandRouter::volumioPlay 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::play index 0 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::stop 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::play index undefined 6月 20 08:48:25 volumior5 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined 6月 20 08:48:25 volumior5 volumio[1436]: info: CorePlayQueue::getTrack 0 6月 20 08:48:26 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri 6月 20 08:48:26 volumior5 volumio[1436]: info: Preload queue cleared 6月 20 08:48:30 volumior5 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri 6月 20 08:48:30 volumior5 volumio[1436]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| 6月 20 08:48:30 volumior5 volumio[1436]: TypeError: Cannot read property 'length' of undefined 6月 20 08:48:30 volumior5 volumio[1436]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 6月 20 08:48:30 volumior5 volumio[1436]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 6月 20 08:48:30 volumior5 volumio[1436]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) 6月 20 08:48:30 volumior5 volumio[1436]: at Parser.emit (events.js:315:20) 6月 20 08:48:30 volumior5 volumio[1436]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) 6月 20 08:48:30 volumior5 volumio[1436]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) 6月 20 08:48:30 volumior5 volumio[1436]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) 6月 20 08:48:30 volumior5 volumio[1436]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) 6月 20 08:48:30 volumior5 volumio[1436]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) 6月 20 08:48:30 volumior5 volumio[1436]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) 6月 20 08:48:30 volumior5 volumio[1436]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) 6月 20 08:48:30 volumior5 volumio[1436]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) 6月 20 08:48:30 volumior5 volumio[1436]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) 6月 20 08:48:30 volumior5 volumio[1436]: at IncomingMessage.emit (events.js:327:22) 6月 20 08:48:30 volumior5 volumio[1436]: at endReadableNT (internal/streams/readable.js:1327:12) 6月 20 08:48:30 volumior5 volumio[1436]: at processTicksAndRejections (internal/process/task_queues.js:80:21) 6月 20 08:48:30 volumior5 volumio[1436]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| 6月 20 08:48:30 volumior5 sudo[1978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-20 08:47 6月 20 08:48:30 volumior5 sudo[1978]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"