-- Logs begin at Sat 2024-11-23 16:08:26 CET, end at Sat 2024-11-23 16:09:33 CET. -- Nov 23 16:08:43 orangepizero kernel: Booting Linux on physical CPU 0x0 Nov 23 16:08:43 orangepizero kernel: Linux version 5.15.93-sunxi (root@thinkcentre) (arm-linux-gnueabihf-gcc (GNU Toolchain for the A-profile Architecture 8.3-2019.03 (arm-rel-8.36)) 8.3.0, GNU ld (GNU Toolchain for the A-profile Architecture 8.3-2019.03 (arm-rel-8.36)) 2.32.0.20190321) #trunk SMP Tue Jul 11 17:28:34 CEST 2023 Nov 23 16:08:43 orangepizero kernel: CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=50c5387d Nov 23 16:08:43 orangepizero kernel: CPU: div instructions available: patching division code Nov 23 16:08:43 orangepizero kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Nov 23 16:08:43 orangepizero kernel: OF: fdt: Machine model: Xunlong Orange Pi PC Nov 23 16:08:43 orangepizero kernel: Memory policy: Data cache writealloc Nov 23 16:08:43 orangepizero kernel: cma: Reserved 104 MiB at 0x59800000 Nov 23 16:08:43 orangepizero kernel: Zone ranges: Nov 23 16:08:43 orangepizero kernel: Normal [mem 0x0000000040000000-0x000000005fffffff] Nov 23 16:08:43 orangepizero kernel: HighMem empty Nov 23 16:08:43 orangepizero kernel: Movable zone start for each node Nov 23 16:08:43 orangepizero kernel: Early memory node ranges Nov 23 16:08:43 orangepizero kernel: node 0: [mem 0x0000000040000000-0x000000005fffffff] Nov 23 16:08:43 orangepizero kernel: Initmem setup node 0 [mem 0x0000000040000000-0x000000005fffffff] Nov 23 16:08:43 orangepizero kernel: psci: probing for conduit method from DT. Nov 23 16:08:43 orangepizero kernel: psci: Using PSCI v0.1 Function IDs from DT Nov 23 16:08:43 orangepizero kernel: percpu: Embedded 17 pages/cpu s38540 r8192 d22900 u69632 Nov 23 16:08:43 orangepizero kernel: pcpu-alloc: s38540 r8192 d22900 u69632 alloc=17*4096 Nov 23 16:08:43 orangepizero kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 23 16:08:43 orangepizero kernel: Built 1 zonelists, mobility grouping on. Total pages: 129920 Nov 23 16:08:43 orangepizero kernel: Kernel command line: root=/dev/mmcblk0p2 rootwait rootfstype=ext4 splash plymouth.ignore-serial-consoles console=ttyS0,115200 console=tty1 hdmi.audio=EDID:0 disp.screen0_output_mode=1920x1080p60 consoleblank=0 loglevel=0 ubootpart=cb3abd76-01 ubootsource=mmc usb-storage.quirks=0x2537:0x1066:u,0x2537:0x1068:u imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh net.ifnames=0 hwver=orangepi sunxi_ve_mem_reserve=0 sunxi_g2d_mem_reserve=0 sunxi_fb_mem_reserve=16 cgroup_enable=memory swapaccount=1 Nov 23 16:08:43 orangepizero kernel: Unknown kernel command line parameters "splash ubootpart=cb3abd76-01 ubootsource=mmc imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh hwver=orangepi sunxi_ve_mem_reserve=0 sunxi_g2d_mem_reserve=0 sunxi_fb_mem_reserve=16 cgroup_enable=memory", will be passed to user space. Nov 23 16:08:43 orangepizero kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 23 16:08:43 orangepizero kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear) Nov 23 16:08:43 orangepizero kernel: mem auto-init: stack:off, heap alloc:on, heap free:off Nov 23 16:08:43 orangepizero kernel: Memory: 380924K/524288K available (9216K kernel code, 1510K rwdata, 3408K rodata, 1024K init, 326K bss, 36868K reserved, 106496K cma-reserved, 0K highmem) Nov 23 16:08:43 orangepizero kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 23 16:08:43 orangepizero kernel: ftrace: allocating 44001 entries in 130 pages Nov 23 16:08:43 orangepizero kernel: ftrace: allocated 129 pages with 2 groups Nov 23 16:08:43 orangepizero kernel: trace event string verifier disabled Nov 23 16:08:43 orangepizero kernel: rcu: Hierarchical RCU implementation. Nov 23 16:08:43 orangepizero kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Nov 23 16:08:43 orangepizero kernel: Rude variant of Tasks RCU enabled. Nov 23 16:08:43 orangepizero kernel: Tracing variant of Tasks RCU enabled. Nov 23 16:08:43 orangepizero kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Nov 23 16:08:43 orangepizero kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 23 16:08:43 orangepizero kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 Nov 23 16:08:43 orangepizero kernel: GIC: Using split EOI/Deactivate mode Nov 23 16:08:43 orangepizero kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns Nov 23 16:08:43 orangepizero kernel: arch_timer: cp15 timer(s) running at 24.00MHz (phys). Nov 23 16:08:43 orangepizero kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns Nov 23 16:08:43 orangepizero kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns Nov 23 16:08:43 orangepizero kernel: Switching to timer-based delay loop, resolution 41ns Nov 23 16:08:43 orangepizero kernel: Console: colour dummy device 80x30 Nov 23 16:08:43 orangepizero kernel: printk: console [tty1] enabled Nov 23 16:08:43 orangepizero kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) Nov 23 16:08:43 orangepizero kernel: pid_max: default: 32768 minimum: 301 Nov 23 16:08:43 orangepizero kernel: LSM: Security Framework initializing Nov 23 16:08:43 orangepizero kernel: Yama: becoming mindful. Nov 23 16:08:43 orangepizero kernel: AppArmor: AppArmor initialized Nov 23 16:08:43 orangepizero kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) Nov 23 16:08:43 orangepizero kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear) Nov 23 16:08:43 orangepizero kernel: CPU: Testing write buffer coherency: ok Nov 23 16:08:43 orangepizero kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Nov 23 16:08:43 orangepizero kernel: Setting up static identity map for 0x40100000 - 0x40100054 Nov 23 16:08:43 orangepizero kernel: rcu: Hierarchical SRCU implementation. Nov 23 16:08:43 orangepizero kernel: smp: Bringing up secondary CPUs ... Nov 23 16:08:43 orangepizero kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Nov 23 16:08:43 orangepizero kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Nov 23 16:08:43 orangepizero kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Nov 23 16:08:43 orangepizero kernel: smp: Brought up 1 node, 4 CPUs Nov 23 16:08:43 orangepizero kernel: SMP: Total of 4 processors activated (192.00 BogoMIPS). Nov 23 16:08:43 orangepizero kernel: CPU: All CPU(s) started in HYP mode. Nov 23 16:08:43 orangepizero kernel: CPU: Virtualization extensions available. Nov 23 16:08:43 orangepizero kernel: allocated 524288 bytes of page_ext Nov 23 16:08:43 orangepizero kernel: devtmpfs: initialized Nov 23 16:08:43 orangepizero kernel: VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5 Nov 23 16:08:43 orangepizero kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Nov 23 16:08:43 orangepizero kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 23 16:08:43 orangepizero kernel: pinctrl core: initialized pinctrl subsystem Nov 23 16:08:43 orangepizero kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 23 16:08:43 orangepizero kernel: DMA: preallocated 256 KiB pool for atomic coherent allocations Nov 23 16:08:43 orangepizero kernel: audit: initializing netlink subsys (disabled) Nov 23 16:08:43 orangepizero kernel: audit: type=2000 audit(0.068:1): state=initialized audit_enabled=0 res=1 Nov 23 16:08:43 orangepizero kernel: thermal_sys: Registered thermal governor 'fair_share' Nov 23 16:08:43 orangepizero kernel: thermal_sys: Registered thermal governor 'bang_bang' Nov 23 16:08:43 orangepizero kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 23 16:08:43 orangepizero kernel: cpuidle: using governor ladder Nov 23 16:08:43 orangepizero kernel: cpuidle: using governor menu Nov 23 16:08:43 orangepizero kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Nov 23 16:08:43 orangepizero kernel: hw-breakpoint: maximum watchpoint size is 8 bytes. Nov 23 16:08:43 orangepizero kernel: platform 1c0c000.lcd-controller: Fixing up cyclic dependency with 1100000.mixer Nov 23 16:08:43 orangepizero kernel: platform 1ee0000.hdmi: Fixing up cyclic dependency with 1c0c000.lcd-controller Nov 23 16:08:43 orangepizero kernel: platform connector: Fixing up cyclic dependency with 1ee0000.hdmi Nov 23 16:08:43 orangepizero kernel: cryptd: max_cpu_qlen set to 1000 Nov 23 16:08:43 orangepizero kernel: raid6: neonx8 gen() 314 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: neonx8 xor() 232 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: neonx4 gen() 335 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: neonx4 xor() 254 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: neonx2 gen() 369 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: neonx2 xor() 263 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: neonx1 gen() 329 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: neonx1 xor() 228 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x8 gen() 122 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x8 xor() 72 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x4 gen() 143 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x4 xor() 83 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x2 gen() 161 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x2 xor() 86 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x1 gen() 162 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: int32x1 xor() 77 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: using algorithm neonx2 gen() 369 MB/s Nov 23 16:08:43 orangepizero kernel: raid6: .... xor() 263 MB/s, rmw enabled Nov 23 16:08:43 orangepizero kernel: raid6: using neon recovery algorithm Nov 23 16:08:43 orangepizero kernel: iommu: Default domain type: Translated Nov 23 16:08:43 orangepizero kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 23 16:08:43 orangepizero kernel: SCSI subsystem initialized Nov 23 16:08:43 orangepizero kernel: libata version 3.00 loaded. Nov 23 16:08:43 orangepizero kernel: usbcore: registered new interface driver usbfs Nov 23 16:08:43 orangepizero kernel: usbcore: registered new interface driver hub Nov 23 16:08:43 orangepizero kernel: usbcore: registered new device driver usb Nov 23 16:08:43 orangepizero kernel: mc: Linux media interface: v0.10 Nov 23 16:08:43 orangepizero kernel: videodev: Linux video capture interface: v2.00 Nov 23 16:08:43 orangepizero kernel: pps_core: LinuxPPS API ver. 1 registered Nov 23 16:08:43 orangepizero kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Nov 23 16:08:43 orangepizero kernel: PTP clock support registered Nov 23 16:08:43 orangepizero kernel: Advanced Linux Sound Architecture Driver Initialized. Nov 23 16:08:43 orangepizero kernel: NetLabel: Initializing Nov 23 16:08:43 orangepizero kernel: NetLabel: domain hash size = 128 Nov 23 16:08:43 orangepizero kernel: NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO Nov 23 16:08:43 orangepizero kernel: NetLabel: unlabeled traffic allowed by default Nov 23 16:08:43 orangepizero kernel: clocksource: Switched to clocksource arch_sys_counter Nov 23 16:08:43 orangepizero kernel: VFS: Disk quotas dquot_6.6.0 Nov 23 16:08:43 orangepizero kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Nov 23 16:08:43 orangepizero kernel: AppArmor: AppArmor Filesystem Enabled Nov 23 16:08:43 orangepizero kernel: NET: Registered PF_INET protocol family Nov 23 16:08:43 orangepizero kernel: IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 23 16:08:43 orangepizero kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) Nov 23 16:08:43 orangepizero kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 23 16:08:43 orangepizero kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear) Nov 23 16:08:43 orangepizero kernel: TCP bind hash table entries: 4096 (order: 3, 32768 bytes, linear) Nov 23 16:08:43 orangepizero kernel: TCP: Hash tables configured (established 4096 bind 4096) Nov 23 16:08:43 orangepizero kernel: UDP hash table entries: 256 (order: 1, 8192 bytes, linear) Nov 23 16:08:43 orangepizero kernel: UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear) Nov 23 16:08:43 orangepizero kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 23 16:08:43 orangepizero kernel: Trying to unpack rootfs image as initramfs... Nov 23 16:08:43 orangepizero kernel: hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available Nov 23 16:08:43 orangepizero kernel: Initialise system trusted keyrings Nov 23 16:08:43 orangepizero kernel: Key type blacklist registered Nov 23 16:08:43 orangepizero kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3 Nov 23 16:08:43 orangepizero kernel: zbud: loaded Nov 23 16:08:43 orangepizero kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 23 16:08:43 orangepizero kernel: fuse: init (API version 7.34) Nov 23 16:08:43 orangepizero kernel: integrity: Platform Keyring initialized Nov 23 16:08:43 orangepizero kernel: xor: measuring software checksum speed Nov 23 16:08:43 orangepizero kernel: arm4regs : 523 MB/sec Nov 23 16:08:43 orangepizero kernel: 8regs : 362 MB/sec Nov 23 16:08:43 orangepizero kernel: 32regs : 343 MB/sec Nov 23 16:08:43 orangepizero kernel: neon : 532 MB/sec Nov 23 16:08:43 orangepizero kernel: xor: using function: neon (532 MB/sec) Nov 23 16:08:43 orangepizero kernel: Key type asymmetric registered Nov 23 16:08:43 orangepizero kernel: Asymmetric key parser 'x509' registered Nov 23 16:08:43 orangepizero kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246) Nov 23 16:08:43 orangepizero kernel: io scheduler mq-deadline registered Nov 23 16:08:43 orangepizero kernel: io scheduler kyber registered Nov 23 16:08:43 orangepizero kernel: io scheduler bfq registered Nov 23 16:08:43 orangepizero kernel: sun8i-h3-pinctrl 1c20800.pinctrl: initialized sunXi PIO driver Nov 23 16:08:43 orangepizero kernel: sun8i-h3-r-pinctrl 1f02c00.pinctrl: initialized sunXi PIO driver Nov 23 16:08:43 orangepizero kernel: Serial: 8250/16550 driver, 8 ports, IRQ sharing disabled Nov 23 16:08:43 orangepizero kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pa not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: printk: console [ttyS0] disabled Nov 23 16:08:43 orangepizero kernel: 1c28000.serial: ttyS0 at MMIO 0x1c28000 (irq = 51, base_baud = 1500000) is a 16550A Nov 23 16:08:43 orangepizero kernel: printk: console [ttyS0] enabled Nov 23 16:08:43 orangepizero kernel: brd: module loaded Nov 23 16:08:43 orangepizero kernel: loop: module loaded Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: IRQ eth_wake_irq not found Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: IRQ eth_lpi not found Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: supply phy not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: supply phy-io not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: PTP uses main clock Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: Current syscon value is not the default 148000 (expect 58000) Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: No HW DMA feature register supported Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: RX Checksum Offload Engine supported Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: COE Type 2 Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: TX Checksum insertion supported Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: Normal descriptors Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: Chain mode enabled Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: Found internal PHY node Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: Switch mux to internal PHY Nov 23 16:08:43 orangepizero kernel: dwmac-sun8i 1c30000.ethernet: Powering internal PHY Nov 23 16:08:43 orangepizero kernel: Freeing initrd memory: 15044K Nov 23 16:08:43 orangepizero kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Nov 23 16:08:43 orangepizero kernel: ehci-platform: EHCI generic platform driver Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1a000.usb: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1a000.usb: new USB bus registered, assigned bus number 1 Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1a000.usb: irq 35, io mem 0x01c1a000 Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1a000.usb: USB 2.0 started, EHCI 1.00 Nov 23 16:08:43 orangepizero kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb1: Product: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: usb usb1: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb1: SerialNumber: 1c1a000.usb Nov 23 16:08:43 orangepizero kernel: hub 1-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 1-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Nov 23 16:08:43 orangepizero kernel: ohci-platform: OHCI generic platform driver Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1a400.usb: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1a400.usb: new USB bus registered, assigned bus number 2 Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1a400.usb: irq 36, io mem 0x01c1a400 Nov 23 16:08:43 orangepizero kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb2: Product: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: usb usb2: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb2: SerialNumber: 1c1a400.usb Nov 23 16:08:43 orangepizero kernel: hub 2-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 2-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: usbcore: registered new interface driver usb-storage Nov 23 16:08:43 orangepizero kernel: sun6i-rtc 1f00000.rtc: registered as rtc0 Nov 23 16:08:43 orangepizero kernel: sun6i-rtc 1f00000.rtc: setting system clock to 2024-11-23T15:08:30 UTC (1732374510) Nov 23 16:08:43 orangepizero kernel: sun6i-rtc 1f00000.rtc: RTC enabled Nov 23 16:08:43 orangepizero kernel: i2c_dev: i2c /dev entries driver Nov 23 16:08:43 orangepizero kernel: sun8i-h3-r-pinctrl 1f02c00.pinctrl: supply vcc-pl not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: sunxi-wdt 1c20ca0.watchdog: Watchdog enabled (timeout=16 sec, nowayout=0) Nov 23 16:08:43 orangepizero kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pf not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: ledtrig-cpu: registered to indicate activity on CPUs Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Set mod clock to 50000000 (50 Mhz) from 24000000 (24 Mhz) Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 23 16:08:43 orangepizero kernel: sunxi-mmc 1c0f000.mmc: Got CD GPIO Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register cbc(aes) Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register ecb(aes) Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register cbc(des3_ede) Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register ecb(des3_ede) Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register md5 Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register sha1 Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register sha224 Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register sha256 Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register sha384 Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register sha512 Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: Register stdrng Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: TRNG not supported Nov 23 16:08:43 orangepizero kernel: sun8i-ce 1c15000.crypto: CryptoEngine Die ID 1 Nov 23 16:08:43 orangepizero kernel: hid: raw HID events driver (C) Jiri Kosina Nov 23 16:08:43 orangepizero kernel: usbcore: registered new interface driver usbhid Nov 23 16:08:43 orangepizero kernel: usbhid: USB HID core driver Nov 23 16:08:43 orangepizero kernel: debugfs: Directory '1c22c00.codec' with parent 'H3 Audio Codec' already present! Nov 23 16:08:43 orangepizero kernel: sunxi-mmc 1c0f000.mmc: initialized, max. request size: 16384 KB Nov 23 16:08:43 orangepizero kernel: Initializing XFRM netlink socket Nov 23 16:08:43 orangepizero kernel: NET: Registered PF_INET6 protocol family Nov 23 16:08:43 orangepizero kernel: mmc0: host does not support reading read-only switch, assuming write-enable Nov 23 16:08:43 orangepizero kernel: mmc0: new high speed SDHC card at address aaaa Nov 23 16:08:43 orangepizero kernel: mmcblk0: mmc0:aaaa SH32G 29.7 GiB Nov 23 16:08:43 orangepizero kernel: mmcblk0: p1 p2 p3 Nov 23 16:08:43 orangepizero kernel: Segment Routing with IPv6 Nov 23 16:08:43 orangepizero kernel: In-situ OAM (IOAM) with IPv6 Nov 23 16:08:43 orangepizero kernel: NET: Registered PF_PACKET protocol family Nov 23 16:08:43 orangepizero kernel: NET: Registered PF_KEY protocol family Nov 23 16:08:43 orangepizero kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 23 16:08:43 orangepizero kernel: 8021q: 802.1Q VLAN Support v1.8 Nov 23 16:08:43 orangepizero kernel: Key type dns_resolver registered Nov 23 16:08:43 orangepizero kernel: Registering SWP/SWPB emulation handler Nov 23 16:08:43 orangepizero kernel: registered taskstats version 1 Nov 23 16:08:43 orangepizero kernel: Loading compiled-in X.509 certificates Nov 23 16:08:43 orangepizero kernel: Loaded X.509 cert 'Build time autogenerated kernel key: 8f8e38801ad26e1c5752b0545ce65e141a715a7d' Nov 23 16:08:43 orangepizero kernel: zswap: loaded using pool zstd/z3fold Nov 23 16:08:43 orangepizero kernel: Key type .fscrypt registered Nov 23 16:08:43 orangepizero kernel: Key type fscrypt-provisioning registered Nov 23 16:08:43 orangepizero kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=yes Nov 23 16:08:43 orangepizero kernel: Key type encrypted registered Nov 23 16:08:43 orangepizero kernel: AppArmor: AppArmor sha1 policy hashing enabled Nov 23 16:08:43 orangepizero kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pg not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: sun4i-drm display-engine: bound 1100000.mixer (ops 0xc0aa3538) Nov 23 16:08:43 orangepizero kernel: sun4i-drm display-engine: bound 1c0c000.lcd-controller (ops 0xc0a9f46c) Nov 23 16:08:43 orangepizero kernel: sun8i-dw-hdmi 1ee0000.hdmi: supply hvcc not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: sun8i-dw-hdmi 1ee0000.hdmi: Detected HDMI TX controller v1.32a with HDCP (sun8i_dw_hdmi_phy) Nov 23 16:08:43 orangepizero kernel: sun8i-dw-hdmi 1ee0000.hdmi: registered DesignWare HDMI I2C bus driver Nov 23 16:08:43 orangepizero kernel: sun4i-drm display-engine: bound 1ee0000.hdmi (ops 0xc0aa2aec) Nov 23 16:08:43 orangepizero kernel: [drm] Initialized sun4i-drm 1.0.0 20150629 for display-engine on minor 0 Nov 23 16:08:43 orangepizero kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1b000.usb: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1b000.usb: new USB bus registered, assigned bus number 3 Nov 23 16:08:43 orangepizero kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1b000.usb: irq 37, io mem 0x01c1b000 Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1b000.usb: USB 2.0 started, EHCI 1.00 Nov 23 16:08:43 orangepizero kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb3: Product: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: usb usb3: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb3: SerialNumber: 1c1b000.usb Nov 23 16:08:43 orangepizero kernel: hub 3-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 3-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1c000.usb: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1c000.usb: new USB bus registered, assigned bus number 4 Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1c000.usb: irq 39, io mem 0x01c1c000 Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1c000.usb: USB 2.0 started, EHCI 1.00 Nov 23 16:08:43 orangepizero kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb4: Product: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: usb usb4: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb4: SerialNumber: 1c1c000.usb Nov 23 16:08:43 orangepizero kernel: hub 4-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 4-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1d000.usb: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1d000.usb: new USB bus registered, assigned bus number 5 Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1d000.usb: irq 41, io mem 0x01c1d000 Nov 23 16:08:43 orangepizero kernel: ehci-platform 1c1d000.usb: USB 2.0 started, EHCI 1.00 Nov 23 16:08:43 orangepizero kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb5: Product: EHCI Host Controller Nov 23 16:08:43 orangepizero kernel: usb usb5: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb5: SerialNumber: 1c1d000.usb Nov 23 16:08:43 orangepizero kernel: hub 5-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 5-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1b400.usb: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1b400.usb: new USB bus registered, assigned bus number 6 Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1b400.usb: irq 38, io mem 0x01c1b400 Nov 23 16:08:43 orangepizero kernel: usb usb6: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb6: Product: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: usb usb6: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb6: SerialNumber: 1c1b400.usb Nov 23 16:08:43 orangepizero kernel: hub 6-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 6-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1c400.usb: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1c400.usb: new USB bus registered, assigned bus number 7 Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1c400.usb: irq 40, io mem 0x01c1c400 Nov 23 16:08:43 orangepizero kernel: usb usb7: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb7: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb7: Product: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: usb usb7: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb7: SerialNumber: 1c1c400.usb Nov 23 16:08:43 orangepizero kernel: hub 7-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 7-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1d400.usb: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1d400.usb: new USB bus registered, assigned bus number 8 Nov 23 16:08:43 orangepizero kernel: ohci-platform 1c1d400.usb: irq 42, io mem 0x01c1d400 Nov 23 16:08:43 orangepizero kernel: usb usb8: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb8: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb8: Product: Generic Platform OHCI controller Nov 23 16:08:43 orangepizero kernel: usb usb8: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 23 16:08:43 orangepizero kernel: usb usb8: SerialNumber: 1c1d400.usb Nov 23 16:08:43 orangepizero kernel: hub 8-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 8-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: of_cfs_init Nov 23 16:08:43 orangepizero kernel: of_cfs_init: OK Nov 23 16:08:43 orangepizero kernel: ALSA device list: Nov 23 16:08:43 orangepizero kernel: #0: H3 Audio Codec Nov 23 16:08:43 orangepizero kernel: Freeing unused kernel image (initmem) memory: 1024K Nov 23 16:08:43 orangepizero kernel: Run /init as init process Nov 23 16:08:43 orangepizero kernel: with arguments: Nov 23 16:08:43 orangepizero kernel: /init Nov 23 16:08:43 orangepizero kernel: splash Nov 23 16:08:43 orangepizero kernel: with environment: Nov 23 16:08:43 orangepizero kernel: HOME=/ Nov 23 16:08:43 orangepizero kernel: TERM=linux Nov 23 16:08:43 orangepizero kernel: ubootpart=cb3abd76-01 Nov 23 16:08:43 orangepizero kernel: ubootsource=mmc Nov 23 16:08:43 orangepizero kernel: imgpart=/dev/mmcblk0p2 Nov 23 16:08:43 orangepizero kernel: imgfile=/volumio_current.sqsh Nov 23 16:08:43 orangepizero kernel: hwver=orangepi Nov 23 16:08:43 orangepizero kernel: sunxi_ve_mem_reserve=0 Nov 23 16:08:43 orangepizero kernel: sunxi_g2d_mem_reserve=0 Nov 23 16:08:43 orangepizero kernel: sunxi_fb_mem_reserve=16 Nov 23 16:08:43 orangepizero kernel: cgroup_enable=memory Nov 23 16:08:43 orangepizero kernel: usb 6-1: new full-speed USB device number 2 using ohci-platform Nov 23 16:08:43 orangepizero kernel: usb 6-1: New USB device found, idVendor=08bb, idProduct=2704, bcdDevice= 1.00 Nov 23 16:08:43 orangepizero kernel: usb 6-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 23 16:08:43 orangepizero kernel: usb 6-1: Product: USB Audio DAC Nov 23 16:08:43 orangepizero kernel: usb 6-1: Manufacturer: Burr-Brown from TI Nov 23 16:08:43 orangepizero kernel: input: Burr-Brown from TI USB Audio DAC as /devices/platform/soc/1c1b400.usb/usb6/6-1/6-1:1.2/0003:08BB:2704.0001/input/input0 Nov 23 16:08:43 orangepizero kernel: hid-generic 0003:08BB:2704.0001: input,hidraw0: USB HID v1.00 Device [Burr-Brown from TI USB Audio DAC ] on usb-1c1b400.usb-1/input2 Nov 23 16:08:43 orangepizero kernel: input: r_gpio_keys as /devices/platform/r_gpio_keys/input/input1 Nov 23 16:08:43 orangepizero kernel: usb_phy_generic usb_phy_generic.3.auto: supply vcc not found, using dummy regulator Nov 23 16:08:43 orangepizero kernel: usb_phy_generic usb_phy_generic.3.auto: dummy supplies not allowed for exclusive requests Nov 23 16:08:43 orangepizero kernel: musb-hdrc musb-hdrc.4.auto: MUSB HDRC host driver Nov 23 16:08:43 orangepizero kernel: musb-hdrc musb-hdrc.4.auto: new USB bus registered, assigned bus number 9 Nov 23 16:08:43 orangepizero kernel: usb usb9: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 23 16:08:43 orangepizero kernel: usb usb9: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 23 16:08:43 orangepizero kernel: usb usb9: Product: MUSB HDRC host driver Nov 23 16:08:43 orangepizero kernel: usb usb9: Manufacturer: Linux 5.15.93-sunxi musb-hcd Nov 23 16:08:43 orangepizero kernel: usb usb9: SerialNumber: musb-hdrc.4.auto Nov 23 16:08:43 orangepizero kernel: hub 9-0:1.0: USB hub found Nov 23 16:08:43 orangepizero kernel: hub 9-0:1.0: 1 port detected Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: gp - mali400 version major 1 minor 1 Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: pp0 - mali400 version major 1 minor 1 Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: pp1 - mali400 version major 1 minor 1 Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: l2 cache 64K, 4-way, 64byte cache line, 64bit external bus Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: bus rate = 200000000 Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: mod rate = 297000000 Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: dev_pm_opp_set_regulators: no regulator (mali) found: -19 Nov 23 16:08:43 orangepizero kernel: lima 1c40000.gpu: Failed to register cooling device Nov 23 16:08:43 orangepizero kernel: [drm] Initialized lima 1.2.0 20200215 for 1c40000.gpu on minor 1 Nov 23 16:08:43 orangepizero kernel: EXT4-fs (mmcblk0p2): recovery complete Nov 23 16:08:43 orangepizero kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Nov 23 16:08:43 orangepizero kernel: loop0: detected capacity change from 0 to 823560 Nov 23 16:08:43 orangepizero kernel: EXT4-fs (mmcblk0p3): recovery complete Nov 23 16:08:43 orangepizero kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Nov 23 16:08:43 orangepizero kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038 (0x7fffffff) Nov 23 16:08:43 orangepizero systemd[1]: Inserted module 'autofs4' Nov 23 16:08:43 orangepizero 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) Nov 23 16:08:43 orangepizero systemd[1]: Detected architecture arm. Nov 23 16:08:43 orangepizero systemd[1]: Set hostname to . Nov 23 16:08:43 orangepizero 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. Nov 23 16:08:43 orangepizero kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 23 16:08:43 orangepizero kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 23 16:08:43 orangepizero kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 23 16:08:43 orangepizero systemd[1]: Listening on RPCbind Server Activation Socket. Nov 23 16:08:43 orangepizero systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 23 16:08:43 orangepizero systemd[1]: Listening on Journal Socket (/dev/log). Nov 23 16:08:43 orangepizero systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 23 16:08:43 orangepizero systemd[1]: Listening on udev Kernel Socket. Nov 23 16:08:43 orangepizero systemd[1]: Listening on Journal Socket. Nov 23 16:08:43 orangepizero kernel: RPC: Registered named UNIX socket transport module. Nov 23 16:08:43 orangepizero kernel: RPC: Registered udp transport module. Nov 23 16:08:43 orangepizero kernel: RPC: Registered tcp transport module. Nov 23 16:08:43 orangepizero kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 23 16:08:43 orangepizero kernel: random: systemd-random-: uninitialized urandom read (512 bytes read) Nov 23 16:08:43 orangepizero kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 23 16:08:43 orangepizero systemd-journald[432]: Journal started Nov 23 16:08:43 orangepizero systemd-journald[432]: Runtime journal (/run/log/journal/5a703333807da7b56c32bbc264a34ac9) is 3.7M, max 30.0M, 26.2M free. Nov 23 16:08:43 orangepizero kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Nov 23 16:08:43 orangepizero kernel: ext4 filesystem being mounted at /swap supports timestamps until 2038 (0x7fffffff) Nov 23 16:08:43 orangepizero fake-hwclock[424]: Current system time: 2024-11-23 15:08:43 Nov 23 16:08:43 orangepizero fake-hwclock[424]: fake-hwclock saved clock information is in the past: 2024-11-23 15:07:27 Nov 23 16:08:43 orangepizero fake-hwclock[424]: To set system time to this saved clock anyway, use "force" Nov 23 16:08:43 orangepizero volumio[433]: 512 MB or less RAM Detected, need to enable swap Nov 23 16:08:43 orangepizero volumio[433]: Enabling Swap Nov 23 16:08:43 orangepizero kernel: Adding 524228k swap on /swap/swapfile. Priority:-2 extents:14 across:25853948k SSFS Nov 23 16:08:43 orangepizero volumio[433]: Setting swappiness to 40 Nov 23 16:08:43 orangepizero volumio[433]: vm.swappiness = 40 Nov 23 16:08:44 orangepizero systemd[1]: Started Create Static Device Nodes in /dev. Nov 23 16:08:44 orangepizero systemd[1]: dynamicswap.service: Succeeded. Nov 23 16:08:44 orangepizero systemd[1]: Reached target Local File Systems (Pre). Nov 23 16:08:44 orangepizero systemd[1]: Mounting /var/spool/cups... Nov 23 16:08:44 orangepizero systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Nov 23 16:08:44 orangepizero systemd[1]: Mounting /var/log... Nov 23 16:08:44 orangepizero systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Nov 23 16:08:44 orangepizero systemd[1]: Mounting /tmp... Nov 23 16:08:44 orangepizero systemd[1]: Starting udev Kernel Device Manager... Nov 23 16:08:44 orangepizero systemd[1]: Mounted /var/spool/cups. Nov 23 16:08:44 orangepizero systemd[1]: Mounted /var/log. Nov 23 16:08:44 orangepizero systemd[1]: Mounted /tmp. Nov 23 16:08:44 orangepizero systemd[1]: Starting Flush Journal to Persistent Storage... Nov 23 16:08:44 orangepizero systemd[1]: Mounting /var/spool/cups/tmp... Nov 23 16:08:44 orangepizero systemd[1]: Started udev Coldplug all Devices. Nov 23 16:08:44 orangepizero systemd[1]: Mounted /var/spool/cups/tmp. Nov 23 16:08:44 orangepizero systemd[1]: Starting Helper to synchronize boot up for ifupdown... Nov 23 16:08:44 orangepizero systemd-udevd[459]: Network interface NamePolicy= disabled on kernel command line, ignoring. Nov 23 16:08:44 orangepizero systemd-journald[432]: Runtime journal (/run/log/journal/5a703333807da7b56c32bbc264a34ac9) is 3.7M, max 30.0M, 26.2M free. Nov 23 16:08:44 orangepizero systemd[1]: Started Flush Journal to Persistent Storage. Nov 23 16:08:44 orangepizero systemd[1]: Started Helper to synchronize boot up for ifupdown. Nov 23 16:08:44 orangepizero systemd[1]: Started udev Kernel Device Manager. Nov 23 16:08:44 orangepizero systemd[1]: Starting Show Plymouth Boot Screen... Nov 23 16:08:44 orangepizero kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Nov 23 16:08:44 orangepizero systemd[1]: plymouth-start.service: Succeeded. Nov 23 16:08:44 orangepizero systemd[1]: Started Show Plymouth Boot Screen. Nov 23 16:08:44 orangepizero kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 23 16:08:44 orangepizero systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Nov 23 16:08:44 orangepizero kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 23 16:08:44 orangepizero systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 23 16:08:44 orangepizero systemd[1]: Reached target Local Encrypted Volumes. Nov 23 16:08:44 orangepizero systemd[1]: Reached target Paths. Nov 23 16:08:45 orangepizero kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 23 16:08:46 orangepizero kernel: sunxi_cedrus: module is from the staging directory, the quality is unknown, you have been warned. Nov 23 16:08:46 orangepizero kernel: cedrus 1c0e000.video-codec: Device registered as /dev/video0 Nov 23 16:08:46 orangepizero systemd-udevd[468]: Using default interface naming scheme 'v240'. Nov 23 16:08:46 orangepizero kernel: debugfs: File 'Capture' in directory 'dapm' already present! Nov 23 16:08:46 orangepizero systemd-udevd[468]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 23 16:08:46 orangepizero systemd-udevd[468]: link_config: could not get ethtool features for eth0 Nov 23 16:08:46 orangepizero systemd-udevd[468]: Could not set offload features of eth0: Device or resource busy Nov 23 16:08:46 orangepizero kernel: Registered IR keymap rc-empty Nov 23 16:08:46 orangepizero kernel: rc rc0: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0 Nov 23 16:08:46 orangepizero kernel: rc rc0: lirc_dev: driver sunxi-ir registered at minor = 0, raw IR receiver, no transmitter Nov 23 16:08:46 orangepizero kernel: input: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0/input2 Nov 23 16:08:46 orangepizero kernel: sunxi-ir 1f02000.ir: initialized sunXi IR driver Nov 23 16:08:47 orangepizero kernel: usbcore: registered new interface driver snd-usb-audio Nov 23 16:08:47 orangepizero systemd-udevd[470]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 23 16:08:48 orangepizero systemd-udevd[469]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 23 16:08:48 orangepizero systemd-udevd[464]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 23 16:08:48 orangepizero systemd-udevd[464]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 23 16:08:49 orangepizero systemd[1]: Found device /dev/mmcblk0p1. Nov 23 16:08:49 orangepizero systemd[1]: Found device /dev/ttyS0. Nov 23 16:08:49 orangepizero systemd-udevd[470]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 23 16:08:50 orangepizero systemd[1]: Starting Show Plymouth Boot Screen... Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in Huge Pages File System being skipped. Nov 23 16:08:50 orangepizero systemd[1]: Starting File System Check on /dev/mmcblk0p1... Nov 23 16:08:50 orangepizero systemd[1]: plymouth-start.service: Succeeded. Nov 23 16:08:50 orangepizero systemd[1]: Started Show Plymouth Boot Screen. Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 23 16:08:50 orangepizero systemd[1]: Started File System Check Daemon to report status. Nov 23 16:08:50 orangepizero systemd-fsck[675]: fsck.fat 4.1 (2017-01-24) Nov 23 16:08:50 orangepizero systemd-fsck[675]: /dev/mmcblk0p1: 257 files, 16530/30651 clusters Nov 23 16:08:50 orangepizero systemd[1]: Started File System Check on /dev/mmcblk0p1. Nov 23 16:08:50 orangepizero systemd[1]: Mounting /boot... Nov 23 16:08:50 orangepizero systemd[1]: Mounted /boot. Nov 23 16:08:50 orangepizero systemd[1]: Reached target Local File Systems. Nov 23 16:08:50 orangepizero systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Nov 23 16:08:50 orangepizero systemd[1]: Starting Preprocess NFS configuration... Nov 23 16:08:50 orangepizero systemd[1]: Starting Raise network interfaces... Nov 23 16:08:50 orangepizero systemd[1]: Started ifup for eth0. Nov 23 16:08:50 orangepizero systemd[1]: Starting Create Volatile Files and Directories... Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 23 16:08:50 orangepizero systemd[1]: plymouth-read-write.service: Succeeded. Nov 23 16:08:50 orangepizero systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Nov 23 16:08:50 orangepizero systemd[1]: Received SIGRTMIN+20 from PID 328 (plymouthd). Nov 23 16:08:50 orangepizero systemd[1]: nfs-config.service: Succeeded. Nov 23 16:08:50 orangepizero systemd[1]: Started Preprocess NFS configuration. Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Nov 23 16:08:50 orangepizero systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Nov 23 16:08:50 orangepizero systemd[1]: Reached target NFS client services. Nov 23 16:08:51 orangepizero systemd[1]: Started Create Volatile Files and Directories. Nov 23 16:08:51 orangepizero systemd[1]: Starting RPC bind portmap service... Nov 23 16:08:51 orangepizero systemd[1]: Starting Update UTMP about System Boot/Shutdown... Nov 23 16:08:51 orangepizero systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Nov 23 16:08:51 orangepizero systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Nov 23 16:08:51 orangepizero systemd[1]: Started RPC bind portmap service. Nov 23 16:08:51 orangepizero systemd[1]: Reached target Remote File Systems (Pre). Nov 23 16:08:51 orangepizero systemd[1]: Reached target Remote File Systems. Nov 23 16:08:51 orangepizero systemd[1]: Reached target RPC Port Mapper. Nov 23 16:08:51 orangepizero systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Nov 23 16:08:51 orangepizero systemd[1]: Started Update UTMP about System Boot/Shutdown. Nov 23 16:08:51 orangepizero systemd[1]: Reached target System Initialization. Nov 23 16:08:51 orangepizero systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 23 16:08:51 orangepizero systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 23 16:08:51 orangepizero systemd[1]: Listening on triggerhappy.socket. Nov 23 16:08:51 orangepizero systemd[1]: Started Daily apt download activities. Nov 23 16:08:51 orangepizero systemd[1]: Started Daily apt upgrade and clean activities. Nov 23 16:08:51 orangepizero systemd[1]: Reached target Timers. Nov 23 16:08:51 orangepizero systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Nov 23 16:08:51 orangepizero systemd[1]: Reached target Sockets. Nov 23 16:08:51 orangepizero systemd[1]: Reached target Basic System. Nov 23 16:08:51 orangepizero systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Nov 23 16:08:51 orangepizero systemd[1]: Starting triggerhappy global hotkey daemon... Nov 23 16:08:51 orangepizero systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Nov 23 16:08:51 orangepizero systemd[1]: Starting Wireless Services... Nov 23 16:08:51 orangepizero kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Nov 23 16:08:51 orangepizero kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Nov 23 16:08:51 orangepizero kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 Nov 23 16:08:51 orangepizero kernel: platform regulatory.0: Falling back to sysfs fallback for: regulatory.db Nov 23 16:08:51 orangepizero systemd[1]: Starting Login Service... Nov 23 16:08:51 orangepizero kernel: cfg80211: failed to load regulatory.db Nov 23 16:08:51 orangepizero systemd[1]: Started UPnP Renderer front-end to MPD. Nov 23 16:08:51 orangepizero systemd[1]: Started Volumio Iptables Module. Nov 23 16:08:51 orangepizero systemd[1]: Starting DHCP Client Daemon... Nov 23 16:08:51 orangepizero systemd[1]: Started volumio-remote-updater.service. Nov 23 16:08:51 orangepizero systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Nov 23 16:08:51 orangepizero thd[708]: Unable to parse trigger line: Nov 23 16:08:51 orangepizero thd[708]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Nov 23 16:08:51 orangepizero thd[708]: Unable to parse trigger line: Nov 23 16:08:51 orangepizero thd[708]: Found socket passed from systemd Nov 23 16:08:51 orangepizero systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Nov 23 16:08:51 orangepizero systemd[1]: Started D-Bus System Message Bus. Nov 23 16:08:51 orangepizero ifup[684]: command failed: No such device (-19) Nov 23 16:08:51 orangepizero systemd[1]: Starting WPA supplicant... Nov 23 16:08:51 orangepizero sh[685]: command failed: No such device (-19) Nov 23 16:08:51 orangepizero systemd[1]: Started Volumio Log Rotation Service. Nov 23 16:08:52 orangepizero systemd[1]: Started Manage Sound Card State (restore and store). Nov 23 16:08:52 orangepizero systemd[1]: Starting Save/Restore Sound Card State... Nov 23 16:08:52 orangepizero systemd[1]: Starting Initialize hardware monitoring sensors... Nov 23 16:08:52 orangepizero alsactl[730]: alsactl 1.1.8 daemon started Nov 23 16:08:52 orangepizero systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Nov 23 16:08:52 orangepizero systemd[1]: Started triggerhappy global hotkey daemon. Nov 23 16:08:52 orangepizero sh[685]: sending commands to master dhcpcd process Nov 23 16:08:52 orangepizero dhcpcd[769]: sending commands to master dhcpcd process Nov 23 16:08:53 orangepizero systemd-logind[714]: New seat seat0. Nov 23 16:08:53 orangepizero ifup[684]: command failed: No such device (-19) Nov 23 16:08:53 orangepizero systemd-logind[714]: Watching system buttons on /dev/input/event1 (r_gpio_keys) Nov 23 16:08:53 orangepizero avahi-daemon[733]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Nov 23 16:08:53 orangepizero avahi-daemon[733]: Successfully dropped root privileges. Nov 23 16:08:53 orangepizero avahi-daemon[733]: avahi-daemon 0.7 starting up. Nov 23 16:08:54 orangepizero dhcpcd[720]: no interfaces have a carrier Nov 23 16:08:54 orangepizero dhcpcd[720]: forked to background, child pid 817 Nov 23 16:08:54 orangepizero dhcpcd[720]: no interfaces have a carrier Nov 23 16:08:54 orangepizero dhcpcd[720]: forked to background, child pid 817 Nov 23 16:08:54 orangepizero kernel: dwmac-sun8i 1c30000.ethernet eth0: PHY [0.1:01] driver [Generic PHY] (irq=POLL) Nov 23 16:08:54 orangepizero kernel: dwmac-sun8i 1c30000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-0 Nov 23 16:08:54 orangepizero kernel: dwmac-sun8i 1c30000.ethernet eth0: No Safety Features support found Nov 23 16:08:54 orangepizero kernel: dwmac-sun8i 1c30000.ethernet eth0: No MAC Management Counters available Nov 23 16:08:54 orangepizero kernel: dwmac-sun8i 1c30000.ethernet eth0: PTP not supported by HW Nov 23 16:08:54 orangepizero kernel: dwmac-sun8i 1c30000.ethernet eth0: configuring for phy/mii link mode Nov 23 16:08:54 orangepizero kernel: dwmac-sun8i 1c30000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off Nov 23 16:08:54 orangepizero dhcpcd[817]: eth0: waiting for carrier Nov 23 16:08:54 orangepizero dhcpcd[817]: eth0: carrier acquired Nov 23 16:08:54 orangepizero dhcpcd[817]: DUID 00:01:00:01:2c:36:07:c2:02:42:53:dc:13:b4 Nov 23 16:08:54 orangepizero dhcpcd[817]: eth0: IAID 53:dc:13:b4 Nov 23 16:08:54 orangepizero dhcpcd[817]: eth0: adding address fe80::66c4:f869:aa17:37a4 Nov 23 16:08:54 orangepizero dhcpcd[817]: ipv6_addaddr1: Permission denied Nov 23 16:08:54 orangepizero dhcpcd[817]: control command: /sbin/dhcpcd eth0 Nov 23 16:08:54 orangepizero dhcpcd[817]: eth0: carrier lost Nov 23 16:08:55 orangepizero dhcpcd[817]: eth0: carrier acquired Nov 23 16:08:55 orangepizero dhcpcd[817]: eth0: IAID 53:dc:13:b4 Nov 23 16:08:55 orangepizero systemd[1]: Started DHCP Client Daemon. Nov 23 16:08:55 orangepizero systemd[1]: Started Save/Restore Sound Card State. Nov 23 16:08:55 orangepizero avahi-daemon[733]: Successfully called chroot(). Nov 23 16:08:55 orangepizero avahi-daemon[733]: Successfully dropped remaining capabilities. Nov 23 16:08:55 orangepizero avahi-daemon[733]: Loading service file /services/volumio.service. Nov 23 16:08:55 orangepizero sensors[829]: cpu_thermal-virtual-0 Nov 23 16:08:55 orangepizero sensors[829]: Adapter: Virtual device Nov 23 16:08:55 orangepizero sensors[829]: temp1: +65.4°C (crit = +105.0°C) Nov 23 16:08:55 orangepizero avahi-daemon[733]: Network interface enumeration completed. Nov 23 16:08:55 orangepizero avahi-daemon[733]: Server startup complete. Host name is orangepizero.local. Local service cookie is 3296757228. Nov 23 16:08:55 orangepizero avahi-daemon[733]: Service "orangepizero" (/services/volumio.service) successfully established. Nov 23 16:08:55 orangepizero systemd[1]: Started Initialize hardware monitoring sensors. Nov 23 16:08:55 orangepizero dhcpcd[817]: eth0: soliciting a DHCP lease Nov 23 16:08:55 orangepizero dhcpcd[817]: eth0: offered 192.168.8.125 from 192.168.8.7 Nov 23 16:08:55 orangepizero dhcpcd[817]: eth0: probing address 192.168.8.125/24 Nov 23 16:08:55 orangepizero volumio-remote-updater[722]: Error: No active session Nov 23 16:08:55 orangepizero volumio-remote-updater[722]: [2024-11-23 16:08:55] [info] asio async_connect error: system:111 (Connection refused) Nov 23 16:08:55 orangepizero volumio-remote-updater[722]: [2024-11-23 16:08:55] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 23 16:08:55 orangepizero volumio-remote-updater[722]: [2024-11-23 16:08:55] [error] handle_connect error: Underlying Transport Error Nov 23 16:08:55 orangepizero systemd[1]: Started Login Service. Nov 23 16:08:55 orangepizero systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 23 16:08:55 orangepizero systemd[1]: Reached target Sound Card. Nov 23 16:08:55 orangepizero sh[685]: eth0=eth0 Nov 23 16:08:55 orangepizero systemd[1]: Started WPA supplicant. Nov 23 16:08:55 orangepizero wpa_supplicant[726]: Successfully initialized wpa_supplicant Nov 23 16:08:56 orangepizero dhcpcd[817]: eth0: soliciting an IPv6 router Nov 23 16:08:56 orangepizero systemd[1]: Started Raise network interfaces. Nov 23 16:08:56 orangepizero systemd[1]: Reached target Network. Nov 23 16:08:56 orangepizero haveged[707]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Nov 23 16:08:56 orangepizero haveged[707]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Nov 23 16:08:56 orangepizero haveged[707]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99916 Nov 23 16:08:56 orangepizero haveged[707]: haveged: fills: 0, generated: 0 Nov 23 16:08:56 orangepizero volumio[718]: Could not open config: /tmp/upmpdcli.conf Nov 23 16:08:56 orangepizero systemd[1]: Starting OpenBSD Secure Shell server... Nov 23 16:08:56 orangepizero systemd[1]: Started Glances. Nov 23 16:08:56 orangepizero systemd[1]: Starting Network Time Service... Nov 23 16:08:56 orangepizero systemd[1]: Reached target Network is Online. Nov 23 16:08:56 orangepizero systemd[1]: Starting /etc/rc.local Compatibility... Nov 23 16:08:56 orangepizero systemd[1]: Starting LSB: Brings up/down network automatically... Nov 23 16:08:56 orangepizero systemd[1]: Starting LSB: disk temperature monitoring daemon... Nov 23 16:08:56 orangepizero systemd[1]: Starting Samba NMB Daemon... Nov 23 16:08:56 orangepizero systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Nov 23 16:08:56 orangepizero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 23 16:08:56 orangepizero systemd[1]: Starting Permit User Sessions... Nov 23 16:08:56 orangepizero systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Nov 23 16:08:56 orangepizero systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Nov 23 16:08:56 orangepizero systemd[1]: Started /etc/rc.local Compatibility. Nov 23 16:08:56 orangepizero systemd[1]: iptables.service: Succeeded. Nov 23 16:08:56 orangepizero loadcpufreq[723]: Loading cpufreq kernel modules...done (none). Nov 23 16:08:56 orangepizero systemd[1]: Started Permit User Sessions. Nov 23 16:08:56 orangepizero systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Nov 23 16:08:57 orangepizero systemd[1]: Starting LSB: set CPUFreq kernel parameters... Nov 23 16:08:57 orangepizero systemd[1]: Starting Hold until boot process finishes up... Nov 23 16:08:57 orangepizero systemd[1]: Starting Terminate Plymouth Boot Screen... Nov 23 16:08:57 orangepizero systemd[1]: Started LSB: disk temperature monitoring daemon. Nov 23 16:08:57 orangepizero systemd[1]: plymouth-quit-wait.service: Succeeded. Nov 23 16:08:57 orangepizero systemd[1]: Started Hold until boot process finishes up. Nov 23 16:08:57 orangepizero systemd[1]: plymouth-quit.service: Succeeded. Nov 23 16:08:57 orangepizero kernel: random: crng init done Nov 23 16:08:57 orangepizero kernel: random: 246 urandom warning(s) missed due to ratelimiting Nov 23 16:08:57 orangepizero systemd[1]: Started Terminate Plymouth Boot Screen. Nov 23 16:08:57 orangepizero systemd[1]: Received SIGRTMIN+21 from PID 328 (n/a). Nov 23 16:08:57 orangepizero systemd[1]: Received SIGRTMIN+21 from PID 328 (n/a). Nov 23 16:08:57 orangepizero ifplugd(eth0)[930]: ifplugd 0.28 initializing. Nov 23 16:08:57 orangepizero ifplugd(eth0)[930]: Using interface eth0/02:42:53:DC:13:B4 with driver (version: Jan_2016) Nov 23 16:08:57 orangepizero ifplugd(eth0)[930]: Using detection mode: SIOCETHTOOL Nov 23 16:08:57 orangepizero ifplugd(eth0)[930]: Initialization complete, link beat detected. Nov 23 16:08:57 orangepizero ntpd[876]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 23 16:08:57 orangepizero ntpd[876]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Nov 23 16:08:57 orangepizero systemd[1]: Started Network Time Service. Nov 23 16:08:57 orangepizero ifplugd(eth0)[930]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 23 16:08:57 orangepizero systemd[1]: Started Getty on tty1. Nov 23 16:08:57 orangepizero systemd[1]: Started Serial Getty on ttyS0. Nov 23 16:08:57 orangepizero systemd[1]: Reached target Login Prompts. Nov 23 16:08:57 orangepizero ntpd[931]: proto: precision = 2.625 usec (-18) Nov 23 16:08:57 orangepizero cpufrequtils[915]: CPUFreq Utilities: Setting ondemand CPUFreq governor...disabled, governor not available...done. Nov 23 16:08:57 orangepizero systemd[1]: Started LSB: set CPUFreq kernel parameters. Nov 23 16:08:57 orangepizero sshd[932]: Server listening on 0.0.0.0 port 22. Nov 23 16:08:57 orangepizero sshd[932]: Server listening on :: port 22. Nov 23 16:08:57 orangepizero systemd[1]: Started OpenBSD Secure Shell server. Nov 23 16:08:57 orangepizero ntpd[931]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 23 16:08:57 orangepizero ntpd[931]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 23 16:08:57 orangepizero ntpd[931]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 697 days ago Nov 23 16:08:57 orangepizero ntpd[931]: Listen and drop on 0 v6wildcard [::]:123 Nov 23 16:08:57 orangepizero ntpd[931]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 23 16:08:57 orangepizero ntpd[931]: Listen normally on 2 lo 127.0.0.1:123 Nov 23 16:08:57 orangepizero ntpd[931]: Listening on routing socket on fd #19 for interface updates Nov 23 16:08:57 orangepizero ntpd[931]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 23 16:08:57 orangepizero ntpd[931]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 23 16:08:58 orangepizero ifplugd(eth0)[930]: client: ifup: interface eth0 already configured Nov 23 16:08:58 orangepizero ifplugd(eth0)[930]: Program executed successfully. Nov 23 16:08:58 orangepizero ifplugd[879]: Network Interface Plugging Daemon...start eth0...done. Nov 23 16:08:58 orangepizero systemd[1]: Started LSB: Brings up/down network automatically. Nov 23 16:08:58 orangepizero ntpd[931]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 23 16:08:59 orangepizero ntpd[931]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 23 16:09:00 orangepizero dhcpcd[817]: eth0: leased 192.168.8.125 for 43200 seconds Nov 23 16:09:00 orangepizero avahi-daemon[733]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.8.125. Nov 23 16:09:00 orangepizero avahi-daemon[733]: New relevant interface eth0.IPv4 for mDNS. Nov 23 16:09:00 orangepizero dhcpcd[817]: eth0: adding route to 192.168.8.0/24 Nov 23 16:09:00 orangepizero avahi-daemon[733]: Registering new address record for 192.168.8.125 on eth0.IPv4. Nov 23 16:09:00 orangepizero dhcpcd[817]: eth0: adding default route via 192.168.8.254 Nov 23 16:09:00 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:00] [info] asio async_connect error: system:111 (Connection refused) Nov 23 16:09:00 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 23 16:09:00 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:00] [error] handle_connect error: Underlying Transport Error Nov 23 16:09:00 orangepizero ntpd[931]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 23 16:09:01 orangepizero ntpd[931]: ntpd exiting on signal 15 (Terminated) Nov 23 16:09:01 orangepizero systemd[1]: Stopping Network Time Service... Nov 23 16:09:01 orangepizero systemd[1]: ntp.service: Succeeded. Nov 23 16:09:01 orangepizero systemd[1]: Stopped Network Time Service. Nov 23 16:09:01 orangepizero systemd[1]: Starting Network Time Service... Nov 23 16:09:01 orangepizero ntpd[981]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 23 16:09:01 orangepizero systemd[1]: Started Network Time Service. Nov 23 16:09:01 orangepizero ntpd[981]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Nov 23 16:09:01 orangepizero ntpd[987]: proto: precision = 2.708 usec (-18) Nov 23 16:09:01 orangepizero ntpd[987]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 23 16:09:01 orangepizero ntpd[987]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 23 16:09:01 orangepizero ntpd[987]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 697 days ago Nov 23 16:09:01 orangepizero ntpd[987]: Listen and drop on 0 v6wildcard [::]:123 Nov 23 16:09:01 orangepizero ntpd[987]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 23 16:09:01 orangepizero ntpd[987]: Listen normally on 2 lo 127.0.0.1:123 Nov 23 16:09:01 orangepizero ntpd[987]: Listen normally on 3 eth0 192.168.8.125:123 Nov 23 16:09:01 orangepizero ntpd[987]: Listening on routing socket on fd #20 for interface updates Nov 23 16:09:01 orangepizero ntpd[987]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 23 16:09:01 orangepizero ntpd[987]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 23 16:09:02 orangepizero ntpd[987]: Soliciting pool server 194.50.19.204 Nov 23 16:09:02 orangepizero kernel: vcc3v0: disabling Nov 23 16:09:02 orangepizero kernel: vcc5v0: disabling Nov 23 16:09:03 orangepizero nmbd[910]: [2024/11/23 16:09:03.658706, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Nov 23 16:09:03 orangepizero nmbd[910]: started asyncdns process 989 Nov 23 16:09:03 orangepizero nmbd[910]: [2024/11/23 16:09:03.684069, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 23 16:09:03 orangepizero systemd[1]: Started Samba NMB Daemon. Nov 23 16:09:03 orangepizero nmbd[910]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 23 16:09:03 orangepizero systemd[1]: Starting Samba Winbind Daemon... Nov 23 16:09:03 orangepizero ntpd[987]: Soliciting pool server 213.136.76.15 Nov 23 16:09:03 orangepizero ntpd[987]: Soliciting pool server 194.50.19.117 Nov 23 16:09:04 orangepizero ntpd[987]: Soliciting pool server 195.201.107.151 Nov 23 16:09:04 orangepizero ntpd[987]: Soliciting pool server 188.174.253.188 Nov 23 16:09:04 orangepizero ntpd[987]: Soliciting pool server 193.203.3.171 Nov 23 16:09:05 orangepizero ntpd[987]: Soliciting pool server 141.98.136.83 Nov 23 16:09:05 orangepizero ntpd[987]: Soliciting pool server 129.250.35.251 Nov 23 16:09:05 orangepizero ntpd[987]: Soliciting pool server 85.215.189.120 Nov 23 16:09:05 orangepizero ntpd[987]: Soliciting pool server 213.239.234.28 Nov 23 16:09:06 orangepizero ntpd[987]: Soliciting pool server 162.159.200.1 Nov 23 16:09:06 orangepizero ntpd[987]: Soliciting pool server 158.220.97.17 Nov 23 16:09:06 orangepizero ntpd[987]: Soliciting pool server 78.47.93.191 Nov 23 16:09:06 orangepizero winbindd[990]: [2024/11/23 16:09:06.842802, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 23 16:09:06 orangepizero winbindd[990]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 23 16:09:07 orangepizero winbindd[990]: [2024/11/23 16:09:07.494070, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 23 16:09:07 orangepizero winbindd[990]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 23 16:09:07 orangepizero systemd[1]: Started Samba Winbind Daemon. Nov 23 16:09:07 orangepizero systemd[1]: Starting Samba SMB Daemon... Nov 23 16:09:07 orangepizero ntpd[987]: Soliciting pool server 158.101.188.125 Nov 23 16:09:07 orangepizero ntpd[987]: Soliciting pool server 185.248.188.98 Nov 23 16:09:07 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:07] [info] asio async_connect error: system:111 (Connection refused) Nov 23 16:09:07 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 23 16:09:07 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:07] [error] handle_connect error: Underlying Transport Error Nov 23 16:09:08 orangepizero ntpd[987]: Soliciting pool server 85.10.240.253 Nov 23 16:09:08 orangepizero ntpd[987]: Soliciting pool server 2a02:8106:21:9400::8 Nov 23 16:08:26 orangepizero ntpd[987]: receive: Unexpected origin timestamp 0xeaec6e97.c91dd651 does not match aorg 0000000000.00000000 from server@158.220.97.17 xmt 0xeaec6e6a.a2188171 Nov 23 16:08:28 orangepizero systemd[1]: Started Samba SMB Daemon. Nov 23 16:08:28 orangepizero smbd[1004]: [2024/11/23 16:08:28.919204, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 23 16:08:28 orangepizero smbd[1004]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 23 16:08:29 orangepizero wireless.js[709]: WIRELESS: No wireless interface, exiting Nov 23 16:08:29 orangepizero iw[1021]: command failed: No such device (-19) Nov 23 16:08:29 orangepizero iwconfig[1024]: Error for wireless request "Set Power Management" (8B2C) : Nov 23 16:08:29 orangepizero iwconfig[1024]: SET failed on device wlan0 ; No such device. Nov 23 16:08:29 orangepizero systemd[1]: wireless.service: Succeeded. Nov 23 16:08:29 orangepizero systemd[1]: Started Wireless Services. Nov 23 16:08:29 orangepizero systemd[1]: Started Volumio Backend Module. Nov 23 16:08:29 orangepizero systemd[1]: Started Volumio Cpu Tweaker. Nov 23 16:08:29 orangepizero systemd[1]: Reached target Multi-User System. Nov 23 16:08:29 orangepizero systemd[1]: Reached target Graphical Interface. Nov 23 16:08:29 orangepizero systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 23 16:08:30 orangepizero systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 23 16:08:30 orangepizero systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 23 16:08:30 orangepizero systemd[1]: Startup finished in 12.664s (kernel) + 35.686s (userspace) = 48.351s. Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: Setting RT Priority for mpd Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: pid 35's current scheduling policy: SCHED_OTHER Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: pid 35's current scheduling priority: 0 Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: Setting MPD Affinity Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: pid 3's current affinity mask: f Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: Error setting new values. Common errors: Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: - Do you have proper administration rights? (super-user?) Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: - Is the governor you requested available and modprobed? Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: - Trying to set an invalid policy? Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: - Trying to set a specific frequency, but userspace governor is not available, Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: for example because of hardware which cannot be set to a specific frequency Nov 23 16:08:30 orangepizero volumio-cpu-tweak[1028]: or because the userspace governor isn't loaded? Nov 23 16:08:30 orangepizero systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 23 16:08:35 orangepizero systemd[1]: systemd-fsckd.service: Succeeded. Nov 23 16:08:40 orangepizero volumio[1027]: info: ------------------------------------------- Nov 23 16:08:40 orangepizero volumio[1027]: info: ----- Volumio3 ---- Nov 23 16:08:40 orangepizero volumio[1027]: info: ------------------------------------------- Nov 23 16:08:40 orangepizero volumio[1027]: info: ----- System startup ---- Nov 23 16:08:40 orangepizero volumio[1027]: info: ------------------------------------------- Nov 23 16:08:44 orangepizero volumio[1027]: info: MYVOLUMIO Environment detected Nov 23 16:08:45 orangepizero volumio[1027]: info: Plugin folders cleanup Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning into folder /volumio/app/plugins/ Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category audio_interface Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category miscellanea Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category music_service Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category plugins.json Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category system_controller Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category user_interface Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning into folder /data/plugins/ Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category music_service Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category system_controller Nov 23 16:08:45 orangepizero volumio[1027]: info: Scanning category system_hardware Nov 23 16:08:45 orangepizero volumio[1027]: info: Plugin folders cleanup completed Nov 23 16:08:45 orangepizero volumio[1027]: info: ------------------------------------------- Nov 23 16:08:45 orangepizero volumio[1027]: info: ----- Core plugins startup ---- Nov 23 16:08:45 orangepizero volumio[1027]: info: ------------------------------------------- Nov 23 16:08:45 orangepizero volumio[1027]: info: Loading plugins from folder /volumio/app/plugins/ Nov 23 16:08:45 orangepizero volumio[1027]: info: Adding plugin upnp to MyMusic Plugins Nov 23 16:08:45 orangepizero volumio[1027]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 23 16:08:45 orangepizero volumio[1027]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 23 16:08:45 orangepizero volumio[1027]: info: Loading plugins from folder /data/plugins/ Nov 23 16:08:45 orangepizero volumio[1027]: info: Loading plugin "system"... Nov 23 16:08:45 orangepizero volumio[1027]: info: Loading plugin "appearance"... Nov 23 16:08:51 orangepizero volumio[1027]: info: Loading plugin "network"... Nov 23 16:08:51 orangepizero volumio[1027]: info: Refreshing Cached IP Addresses Nov 23 16:08:51 orangepizero volumio[1027]: info: Loading plugin "services"... Nov 23 16:08:51 orangepizero volumio[1027]: info: Loading plugin "alsa_controller"... Nov 23 16:08:51 orangepizero sudo[1065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 23 16:08:51 orangepizero sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 23 16:08:51 orangepizero sudo[1065]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:08:51 orangepizero sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:08:51 orangepizero sudo[1065]: pam_unix(sudo:session): session closed for user root Nov 23 16:08:51 orangepizero sudo[1067]: pam_unix(sudo:session): session closed for user root Nov 23 16:08:51 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 23 16:08:51 orangepizero volumio[1027]: info: Loading plugin "wizard"... Nov 23 16:08:51 orangepizero volumio[1027]: info: Loading plugin "networkfs"... Nov 23 16:08:52 orangepizero volumio[1027]: info: Starting Udev Watcher for removable devices Nov 23 16:08:52 orangepizero sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=radxa,password=Katzeb1x,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.8.33/homes/SSD2TB/music /mnt/NAS/music Nov 23 16:08:52 orangepizero sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:08:52 orangepizero sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=radxa,password=Katzeb1x,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.8.33/homes/SSD2TB/syncthing/Danielmp3s /mnt/NAS/danielmp3 Nov 23 16:08:52 orangepizero sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:08:52 orangepizero volumio[1027]: info: Ignoring mount for partition: boot Nov 23 16:08:52 orangepizero volumio[1027]: info: Ignoring mount for partition: volumio Nov 23 16:08:52 orangepizero volumio[1027]: info: Ignoring mount for partition: volumio_data Nov 23 16:08:52 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 23 16:08:52 orangepizero volumio[1027]: info: Loading plugin "volumio_command_line_client"... Nov 23 16:08:52 orangepizero volumio[1027]: info: Loading plugin "upnp"... Nov 23 16:08:52 orangepizero volumio[1027]: info: [1732374532370] Starting Upmpd Daemon Nov 23 16:08:52 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 23 16:08:52 orangepizero volumio[1027]: info: Loading plugin "my_music"... Nov 23 16:08:52 orangepizero volumio[1027]: info: Loading plugin "mpd"... Nov 23 16:08:52 orangepizero kernel: FS-Cache: Loaded Nov 23 16:08:53 orangepizero kernel: FS-Cache: Netfs 'cifs' registered for caching Nov 23 16:08:53 orangepizero kernel: Key type cifs.spnego registered Nov 23 16:08:53 orangepizero kernel: Key type cifs.idmap registered Nov 23 16:08:53 orangepizero kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Nov 23 16:08:53 orangepizero kernel: CIFS: Attempting to mount \\192.168.8.33\homes Nov 23 16:08:53 orangepizero kernel: CIFS: Attempting to mount \\192.168.8.33\homes Nov 23 16:08:53 orangepizero kernel: FS-Cache: Duplicate cookie detected Nov 23 16:08:53 orangepizero kernel: FS-Cache: O-cookie c=00000003 [p=00000002 fl=222 nc=0 na=1] Nov 23 16:08:53 orangepizero kernel: FS-Cache: O-cookie d=0ae95a96{CIFS.server} n=c56cf8a5 Nov 23 16:08:53 orangepizero kernel: FS-Cache: O-key=[8] '020001bdc0a80821' Nov 23 16:08:53 orangepizero kernel: FS-Cache: N-cookie c=00000004 [p=00000002 fl=2 nc=0 na=1] Nov 23 16:08:53 orangepizero kernel: FS-Cache: N-cookie d=0ae95a96{CIFS.server} n=7ee6b8dc Nov 23 16:08:53 orangepizero kernel: FS-Cache: N-key=[8] '020001bdc0a80821' Nov 23 16:08:53 orangepizero sudo[1077]: pam_unix(sudo:session): session closed for user root Nov 23 16:08:53 orangepizero sudo[1079]: pam_unix(sudo:session): session closed for user root Nov 23 16:08:54 orangepizero volumio[1027]: info: Loading plugin "upnp_browser"... Nov 23 16:08:56 orangepizero volumio[1027]: info: Loading plugin "alarm-clock"... Nov 23 16:08:57 orangepizero volumio[1027]: info: Plugin airplay_emulation is not enabled Nov 23 16:08:57 orangepizero volumio[1027]: info: Loading plugin "last_100"... Nov 23 16:08:57 orangepizero volumio[1027]: info: Loading plugin "webradio"... Nov 23 16:08:57 orangepizero volumio[1027]: info: Loading plugin "i2s_dacs"... Nov 23 16:08:57 orangepizero volumio[1027]: info: I2S DAC not set, start Auto-detection Nov 23 16:08:57 orangepizero volumio[1027]: info: Loading plugin "volumiodiscovery"... Nov 23 16:08:57 orangepizero volumio[1027]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 23 16:08:57 orangepizero volumio[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 16:08:57 orangepizero volumio[1027]: *** WARNING *** For more information see Nov 23 16:08:57 orangepizero node[1027]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 23 16:08:57 orangepizero volumio[1027]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 23 16:08:57 orangepizero volumio[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 16:08:57 orangepizero volumio[1027]: *** WARNING *** For more information see Nov 23 16:08:57 orangepizero node[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 16:08:57 orangepizero node[1027]: *** WARNING *** For more information see Nov 23 16:08:57 orangepizero node[1027]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 23 16:08:57 orangepizero node[1027]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 16:08:57 orangepizero node[1027]: *** WARNING *** For more information see Nov 23 16:08:57 orangepizero volumio[1027]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 23 16:08:57 orangepizero volumio[1027]: info: Discovery: Started advertising with name: orangepizero Nov 23 16:08:58 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 23 16:08:58 orangepizero volumio[1027]: info: Loading plugin "soundcloud"... Nov 23 16:09:00 orangepizero volumio[1027]: info: Loading plugin "spop"... Nov 23 16:09:05 orangepizero volumio[1027]: info: Loading plugin "outputs"... Nov 23 16:09:05 orangepizero volumio[1027]: info: Loading plugin "albumart"... Nov 23 16:09:05 orangepizero volumio[1027]: info: Plugin example_plugin is not enabled Nov 23 16:09:05 orangepizero volumio[1027]: info: Loading plugin "inputs"... Nov 23 16:09:05 orangepizero volumio[1027]: info: Loading plugin "updater_comm"... Nov 23 16:09:06 orangepizero volumio[1027]: info: Plugin mpdemulation is not enabled Nov 23 16:09:06 orangepizero volumio[1027]: info: Loading plugin "rest_api"... Nov 23 16:09:06 orangepizero volumio[1027]: info: Loading plugin "websocket"... Nov 23 16:09:06 orangepizero volumio[1027]: info: Starting Socket.io Server version 2.3.0 Nov 23 16:09:06 orangepizero volumio[1027]: info: Loading plugin "80s80s"... Nov 23 16:09:07 orangepizero volumio[1027]: Forking 3 albumart workers Nov 23 16:09:08 orangepizero volumio[1027]: info: Applying required configuration parameters for plugin 80s80s Nov 23 16:09:08 orangepizero volumio[1027]: info: [1732374548312] [80s80s] API delay: 30 Nov 23 16:09:08 orangepizero volumio[1027]: info: Plugin radio_paradise is not enabled Nov 23 16:09:08 orangepizero volumio[1027]: info: Loading plugin "backup_restore"... Nov 23 16:09:09 orangepizero volumio[1027]: info: Applying required configuration parameters for plugin backup_restore Nov 23 16:09:09 orangepizero volumio[1027]: info: Loading plugin "onkyo_control"... Nov 23 16:09:11 orangepizero volumio[1027]: Starting albumart workers Nov 23 16:09:11 orangepizero volumio[1027]: Starting albumart workers Nov 23 16:09:11 orangepizero volumio[1027]: Starting albumart workers Nov 23 16:09:11 orangepizero volumio[1027]: info: Applying required configuration parameters for plugin onkyo_control Nov 23 16:09:12 orangepizero volumio[1027]: info: Loading i18n strings for locale de Nov 23 16:09:12 orangepizero volumio[1027]: Updating browse sources language Nov 23 16:09:12 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::initPlayerControls Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 16:09:13 orangepizero volumio[1027]: Express server listening on port 3000 Nov 23 16:09:13 orangepizero volumio[1027]: [Metrics] WebUI: 36s 618.30ms Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreStateMachine::resetVolumioState Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreStateMachine::getcurrentVolume Nov 23 16:09:13 orangepizero volumio[1027]: info: CoreCommandRouter::volumioRetrievevolume Nov 23 16:09:14 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 16:09:14 orangepizero sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 23 16:09:14 orangepizero sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:14 orangepizero sudo[1203]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:14 orangepizero volumio[1027]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 23 16:09:14 orangepizero sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 23 16:09:14 orangepizero volumio[1027]: info: Completed loading Core Plugins Nov 23 16:09:14 orangepizero sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:14 orangepizero volumio[1027]: info: Preparing to generate the ALSA configuration file Nov 23 16:09:14 orangepizero sudo[1205]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:15 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 23 16:09:15 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Nov 23 16:09:15 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 23 16:09:15 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 23 16:09:15 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:15 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:15 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:15 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:15 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 23 16:09:15 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 23 16:09:15 orangepizero volumio[1027]: info: VolumeController:: Volume=100 Mute =false Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreStateMachine::pushState Nov 23 16:09:15 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreStateMachine::updateTrackBlock Nov 23 16:09:15 orangepizero volumio[1027]: info: CorePlayQueue::getTrackBlock Nov 23 16:09:15 orangepizero volumio[1027]: info: CoreCommandRouter::volumioRetrievevolume Nov 23 16:09:15 orangepizero volumio[1027]: info: Reloading queue from file Nov 23 16:09:15 orangepizero volumio[1027]: info: Asound.conf file unchanged, so no further update is needed Nov 23 16:09:15 orangepizero volumio[1027]: info: Output device has changed, restarting MPD Nov 23 16:09:16 orangepizero volumio[1027]: info: ___________ START PLUGINS ___________ Nov 23 16:09:16 orangepizero sudo[1218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 23 16:09:16 orangepizero sudo[1218]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:16 orangepizero sudo[1218]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:16 orangepizero volumio[1027]: info: ControllerMpd::onStart: Initializing MPD Nov 23 16:09:16 orangepizero sudo[1220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 23 16:09:16 orangepizero volumio[1027]: info: Creating MPD Configuration file Nov 23 16:09:16 orangepizero sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 16:09:16 orangepizero sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 23 16:09:16 orangepizero volumio[1027]: info: [1732374556209] CoreMusicLibrary::Adding element Medienserver Nov 23 16:09:16 orangepizero sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:16 orangepizero sudo[1224]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:16 orangepizero systemd[1]: Listening on mpd.socket. Nov 23 16:09:16 orangepizero sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 23 16:09:16 orangepizero sudo[1226]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:16 orangepizero systemd[1]: Starting Music Player Daemon... Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 16:09:16 orangepizero volumio[1027]: info: [1732374556348] CoreMusicLibrary::Adding element Last_100 Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 16:09:16 orangepizero volumio[1027]: info: [1732374556362] CoreMusicLibrary::Adding element Webradio Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 23 16:09:16 orangepizero systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 23 16:09:16 orangepizero systemd[1]: mpd.service: Succeeded. Nov 23 16:09:16 orangepizero systemd[1]: Stopped Music Player Daemon. Nov 23 16:09:16 orangepizero volumio[1027]: info: Initializing BBC Radios Nov 23 16:09:16 orangepizero systemd[1]: Starting Music Player Daemon... Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 16:09:16 orangepizero volumio[1027]: info: [1732374556670] CoreMusicLibrary::Adding element SoundCloud Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:16 orangepizero volumio[1027]: Cannot find translation for source SoundCloud Nov 23 16:09:16 orangepizero volumio[1027]: info: Creating Spotify config file Nov 23 16:09:16 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:16 orangepizero sudo[1231]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 23 16:09:16 orangepizero sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:16 orangepizero sudo[1231]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Nov 23 16:09:16 orangepizero sudo[1231]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 16:09:17 orangepizero volumio[1027]: info: [1732374557179] CoreMusicLibrary::Adding element 80s80s Radio Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:17 orangepizero volumio[1027]: Cannot find translation for source SoundCloud Nov 23 16:09:17 orangepizero volumio[1027]: Cannot find translation for source 80s80s Radio Nov 23 16:09:17 orangepizero volumio[1027]: info: Volumio Calling Home Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreStateMachine::setRepeat false single undefined Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreStateMachine::pushState Nov 23 16:09:17 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreStateMachine::setRandom false Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreStateMachine::pushState Nov 23 16:09:17 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 16:09:17 orangepizero volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 23 16:09:17 orangepizero volumio[1027]: info: Listing playlists Nov 23 16:09:17 orangepizero volumio[1027]: info: Listing playlists Nov 23 16:09:17 orangepizero volumio[1027]: info: Listing playlists Nov 23 16:09:17 orangepizero volumio[1027]: info: Listing playlists Nov 23 16:09:17 orangepizero volumio[1027]: info: Listing playlists Nov 23 16:09:17 orangepizero volumio[1027]: info: Listing playlists Nov 23 16:09:17 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:17] [connect] Successful connection Nov 23 16:09:18 orangepizero volumio[1027]: info: ONKYO-CONTROL: *********** ONKYO PLUGIN STARTED ******** Nov 23 16:09:18 orangepizero volumio[1027]: info: MPD Permissions set Nov 23 16:09:18 orangepizero volumio[1027]: info: MPD Permissions set Nov 23 16:09:18 orangepizero sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 23 16:09:18 orangepizero sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:18 orangepizero volumio-remote-updater[722]: [2024-11-23 16:09:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732374557 101 Nov 23 16:09:18 orangepizero volumio[1027]: 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: 8 Nov 23 16:09:18 orangepizero volumio[1027]: info: VolumeController:: Volume=100 Mute =false Nov 23 16:09:18 orangepizero systemd[1]: Started UPnP Renderer front-end to MPD. Nov 23 16:09:18 orangepizero volumio[1027]: info: CoreStateMachine::pushState Nov 23 16:09:18 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:18 orangepizero volumio[1027]: info: CoreCommandRouter::volumioPushState Nov 23 16:09:18 orangepizero sudo[1249]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:18 orangepizero volumio[1027]: info: Volumio called home Nov 23 16:09:18 orangepizero volumio[1027]: info: Spotify config file written Nov 23 16:09:18 orangepizero volumio[1027]: info: Discovery: adding 125d9aef-325f-4315-a1ee-75e451f01635 Nov 23 16:09:18 orangepizero volumio[1027]: info: Discovery: Found device orangepizero Nov 23 16:09:18 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:18 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:18 orangepizero sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 23 16:09:18 orangepizero sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:19 orangepizero systemd[1]: Started go-librespot Daemon. Nov 23 16:09:19 orangepizero go-librespot[1255]: Librespot-go daemon starting... Nov 23 16:09:19 orangepizero sudo[1253]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:19 orangepizero volumio[1027]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Nov 23 16:09:19 orangepizero volumio[1027]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Nov 23 16:09:19 orangepizero volumio[1027]: info: Upmpdcli Daemon Started Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 23 16:09:19 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 16:09:19 orangepizero sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 23 16:09:19 orangepizero sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:19 orangepizero sudo[1275]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:19 orangepizero sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 23 16:09:19 orangepizero sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 16:09:19 orangepizero go-librespot[1255]: time="2024-11-23T16:09:19+01:00" level=info msg="generated new device id: 3efd657af1e01e756bdc63bc1590bef9bb48e7be" Nov 23 16:09:19 orangepizero go-librespot[1255]: time="2024-11-23T16:09:19+01:00" level=debug msg="stored credentials found for 31wtd2im3tsjkl5cavtu7nq7ciji" Nov 23 16:09:19 orangepizero sudo[1277]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:20 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:20 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:20 orangepizero volumio[1027]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 23 16:09:20 orangepizero volumio[1027]: SPOTIFY: BQChzfNQlU88B4UqopIlAxLeGOk-TylLfRTWZpEXXc4y66xCzAOAai6rnEzs0zVO87MSexiiJuGmXZppNPambGFvQWSSC2G3EcYZLF7rGahPopms7oWuLWOWWGwt9VsC1WB1odXYhncwxCM4hC6S86jSKmg5oOE_jgp-AGl3P5rgZOgOSF4i5mkj43TEKmiS_3MB9y8FXHvKJl218Ctk7eVGRBwwUsBkeWy2jmcqYQ9pyhxJGsqEXxdRhD4hMKaG0AVCfUFQLih7PXAKYIY Nov 23 16:09:20 orangepizero volumio[1027]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 23 16:09:20 orangepizero volumio[1027]: info: New Spotify access token = BQChzfNQlU88B4UqopIlAxLeGOk-TylLfRTWZpEXXc4y66xCzAOAai6rnEzs0zVO87MSexiiJuGmXZppNPambGFvQWSSC2G3EcYZLF7rGahPopms7oWuLWOWWGwt9VsC1WB1odXYhncwxCM4hC6S86jSKmg5oOE_jgp-AGl3P5rgZOgOSF4i5mkj43TEKmiS_3MB9y8FXHvKJl218Ctk7eVGRBwwUsBkeWy2jmcqYQ9pyhxJGsqEXxdRhD4hMKaG0AVCfUFQLih7PXAKYIY Nov 23 16:09:20 orangepizero volumio[1027]: info: Spotify credentials grant success - running version from March 24, 2019 Nov 23 16:09:20 orangepizero volumio[1027]: verbose: New Socket.io Connection to 192.168.8.125 from 192.168.8.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 23 16:09:20 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:20 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:20 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:20 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:21 orangepizero volumio[1027]: info: ONKYO-CONTROL: New state: {"status":"stop","position":0,"title":"Fine Day - BLR Afro Summer Mix","artist":"Estiva","album":"Fine Day (BLR Afro Summer Mix)","albumart":"https://i.scdn.co/image/ab67616d0000b27348f39bd388deb71fb54c611b","uri":"spotify:track:1MYPCcjGTjdpyU3fB3Fj49","trackType":"spotify","codec":"ogg","seek":0,"duration":238,"samplerate":"320 kbps","bitdepth":"16 bit","random":false,"repeat":false,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","updatedb":false,"volatile":false,"service":"spop"} connection: {"reconnect":true,"verify_commands":false,"port":60128,"host":"192.168.8.104","model":"TX-NR646"} Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetVisibleSources Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:21 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 23 16:09:21 orangepizero go-librespot[1255]: time="2024-11-23T16:09:21+01:00" level=debug msg="obtained new client token: AACo3bOOwt+mTU1cdxhO/HbuaNbqDqSbTKb4KIAH5wzqq3Lf5kZL2DhwfS3E/FEoEwHeA8RJzyLMqZlStJ54uFkzzmG/cALDHZbfQPE4nP0x3N9lmZzk26S+ZGHSeDJ7eIYuSKkgx20t7zNY1AoTIw7bQ/P0VU/nKwqr682m8E3/C7nZqMNLS9R5okFG9cZNk7EVDjWRwTLcX26Mjx/0RE2uTPLmESaR4KRPvQ6qec4dMwAYJKWAH1zvYN4aTRAF" Nov 23 16:09:21 orangepizero volumio[1027]: info: Received Get System Info Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 23 16:09:21 orangepizero volumio[1027]: info: Discovery: Getting this device information Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:21 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:21 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:21 orangepizero volumio[1027]: info: Listing playlists Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 23 16:09:21 orangepizero go-librespot[1255]: time="2024-11-23T16:09:21+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Nov 23 16:09:21 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:21 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:22 orangepizero go-librespot[1255]: time="2024-11-23T16:09:22+01:00" level=debug msg="completed keyexchange" Nov 23 16:09:22 orangepizero volumio[1027]: SPOTIFY: User informations: {"country":"DE","display_name":"Daniel","email":"daniel-bredendiek@web.de","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31wtd2im3tsjkl5cavtu7nq7ciji"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31wtd2im3tsjkl5cavtu7nq7ciji","id":"31wtd2im3tsjkl5cavtu7nq7ciji","images":[],"product":"premium","type":"user","uri":"spotify:user:31wtd2im3tsjkl5cavtu7nq7ciji"} Nov 23 16:09:22 orangepizero volumio[1027]: info: Spotify Successfully logged in Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 16:09:22 orangepizero volumio[1027]: info: [1732374562164] CoreMusicLibrary::Adding element Spotify Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 16:09:22 orangepizero volumio[1027]: Cannot find translation for source SoundCloud Nov 23 16:09:22 orangepizero volumio[1027]: Cannot find translation for source 80s80s Radio Nov 23 16:09:22 orangepizero volumio[1027]: Cannot find translation for source Spotify Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 23 16:09:22 orangepizero volumio[1027]: info: Received Get System Info Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 23 16:09:22 orangepizero volumio[1027]: info: Discovery: Getting this device information Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:22 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:22 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:22 orangepizero go-librespot[1255]: time="2024-11-23T16:09:22+01:00" level=debug msg="completed challenge" Nov 23 16:09:22 orangepizero go-librespot[1255]: time="2024-11-23T16:09:22+01:00" level=debug msg="authenticated as 31wtd2im3tsjkl5cavtu7nq7ciji" Nov 23 16:09:22 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 23 16:09:22 orangepizero go-librespot[1255]: time="2024-11-23T16:09:22+01:00" level=debug msg="authenticated as 31wtd2im3tsjkl5cavtu7nq7ciji" Nov 23 16:09:22 orangepizero go-librespot[1255]: time="2024-11-23T16:09:22+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="dealer connection opened" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="received connection id: ZThmNjA3NjItODM2Zi00YjUyLWE5M2UtODk5YWUxNjRlMjg3K2RlYWxlcit0Y3A6Ly8wYWNhNTkwMi5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArNTRFOUVCRTZDMUMxNzhEREM5QUQ2OEE4QkJGQ0JBNEREMTVGMEM1MEQ3QjA2QjY2RjIzQ0U4MEM3RUU5NzdCOQ==" Nov 23 16:09:23 orangepizero volumio[1027]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 23 16:09:23 orangepizero volumio[1027]: info: go-librespot daemon successfully initialized Nov 23 16:09:23 orangepizero go-librespot[1255]: time="2024-11-23T16:09:23+01:00" level=debug msg="put connect state because NEW_DEVICE" Nov 23 16:09:26 orangepizero volumio[1027]: info: Initializing connection to go-librespot Websocket Nov 23 16:09:26 orangepizero go-librespot[1255]: time="2024-11-23T16:09:26+01:00" level=debug msg="new websocket client" Nov 23 16:09:26 orangepizero volumio[1027]: info: Connection to go-librespot Websocket established Nov 23 16:09:27 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:27 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:28 orangepizero mpd[1243]: Nov 23 16:09 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 23 16:09:28 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:28 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:28 orangepizero go-librespot[1255]: time="2024-11-23T16:09:28+01:00" level=debug msg="handling transfer player command from e7a02be3ba883fa6873290af120bcfcf3e65b0d3" Nov 23 16:09:28 orangepizero go-librespot[1255]: time="2024-11-23T16:09:28+01:00" level=trace msg="fetched new page 0 with 38 items (list: 38)" Nov 23 16:09:28 orangepizero go-librespot[1255]: time="2024-11-23T16:09:28+01:00" level=debug msg="loading track spotify:track:5yXXMumEYCbWwQ6DIc78Rw (paused: true, position: 841ms)" Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=trace msg="emitting websocket event: will_play" Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1133" Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Nov 23 16:09:29 orangepizero volumio[1027]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:5yXXMumEYCbWwQ6DIc78Rw","play_origin":"android-auto"}} Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:5yXXMumEYCbWwQ6DIc78Rw" Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=debug msg="requested aes key for file 67f8a64f7a21ec4582b54fb8b721c234e33a44a7, gid: 5yXXMumEYCbWwQ6DIc78Rw" Nov 23 16:09:29 orangepizero systemd[1]: Started Music Player Daemon. Nov 23 16:09:29 orangepizero sudo[1220]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:29 orangepizero sudo[1226]: pam_unix(sudo:session): session closed for user root Nov 23 16:09:29 orangepizero volumio[1027]: info: Getting Spotify volume Nov 23 16:09:29 orangepizero volumio[1027]: Upnp client error: Error: This socket has been ended by the other party Nov 23 16:09:29 orangepizero volumio[1027]: Upnp client error: Error: This socket has been ended by the other party Nov 23 16:09:29 orangepizero volumio[1027]: info: Completed starting Core Plugins Nov 23 16:09:29 orangepizero volumio[1027]: info: ------------------------------------------- Nov 23 16:09:29 orangepizero volumio[1027]: info: ----- MyVolumio plugins startup ---- Nov 23 16:09:29 orangepizero volumio[1027]: info: ------------------------------------------- Nov 23 16:09:29 orangepizero volumio[1027]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=debug msg="fetched first chunk of 37, total size is 18909182 bytes" Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=warning msg="reducing track normalisation factor to prevent clipping, please add negative pregain to avoid" Nov 23 16:09:29 orangepizero go-librespot[1255]: time="2024-11-23T16:09:29+01:00" level=trace msg="seek to 841ms (diff: 201ms, samples: 37088, bytes: 22034)" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="fetched chunk 1/36, size: 524288" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=info msg="loaded track \"Magic\" (uri: spotify:track:5yXXMumEYCbWwQ6DIc78Rw, paused: true, position: 841ms, duration: 426895ms)" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="fetched chunk 3/36, size: 524288" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=trace msg="emitting websocket event: metadata" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=trace msg="emitting websocket event: active" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="sending successful reply for delaer request" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Nov 23 16:09:30 orangepizero volumio[1027]: error: MPD error: The expression evaluated to a falsy value: Nov 23 16:09:30 orangepizero volumio[1027]: assert.ok(self.idling) Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="fetched chunk 2/36, size: 524288" Nov 23 16:09:30 orangepizero volumio[1027]: error: The expression evaluated to a falsy value: Nov 23 16:09:30 orangepizero volumio[1027]: assert.ok(self.idling) Nov 23 16:09:30 orangepizero volumio[1027]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Nov 23 16:09:30 orangepizero volumio[1027]: info: MPD running with PID1243 Nov 23 16:09:30 orangepizero volumio[1027]: ,establishing connection Nov 23 16:09:30 orangepizero volumio[1027]: error: updateQueue error: null Nov 23 16:09:30 orangepizero volumio[1027]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:5yXXMumEYCbWwQ6DIc78Rw","name":"Magic","artist_names":["Rod Brito"],"album_name":"Midgard","album_cover_url":"https://i.scdn.co/image/ab67616d00001e022eca60c3da4c506d6f45f7aa","position":841,"duration":426895,"release_date":"year:2024 month:3 day:15","track_number":1,"disc_number":1}} Nov 23 16:09:30 orangepizero volumio[1027]: SPOTIFY: received: {"type":"active","data":null} Nov 23 16:09:30 orangepizero volumio[1027]: info: Aligning Spotify Volume to Volumio Volume Nov 23 16:09:30 orangepizero volumio[1027]: info: CoreCommandRouter::volumioGetState Nov 23 16:09:30 orangepizero volumio[1027]: info: CorePlayQueue::getTrack 0 Nov 23 16:09:30 orangepizero volumio[1027]: info: Setting Spotify Volume from Volumio: 100 Nov 23 16:09:30 orangepizero volumio[1027]: info: Spotify volume: 100 Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 23 16:09:30 orangepizero go-librespot[1255]: time="2024-11-23T16:09:30+01:00" level=trace msg="emitting websocket event: paused" Nov 23 16:09:30 orangepizero volumio[1027]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:5yXXMumEYCbWwQ6DIc78Rw","play_origin":"android-auto"}} Nov 23 16:09:30 orangepizero volumio[1027]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 16:09:30 orangepizero volumio[1027]: TypeError: Cannot read property 'service' of undefined Nov 23 16:09:30 orangepizero volumio[1027]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) Nov 23 16:09:30 orangepizero volumio[1027]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:270:18) Nov 23 16:09:30 orangepizero volumio[1027]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Nov 23 16:09:30 orangepizero volumio[1027]: at WebSocket.emit (events.js:400:28) Nov 23 16:09:30 orangepizero volumio[1027]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1209:20) Nov 23 16:09:30 orangepizero volumio[1027]: at Receiver.emit (events.js:400:28) Nov 23 16:09:30 orangepizero volumio[1027]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:594:14) Nov 23 16:09:30 orangepizero volumio[1027]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Nov 23 16:09:30 orangepizero volumio[1027]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Nov 23 16:09:30 orangepizero volumio[1027]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Nov 23 16:09:30 orangepizero volumio[1027]: at writeOrBuffer (internal/streams/writable.js:358:12) Nov 23 16:09:30 orangepizero volumio[1027]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Nov 23 16:09:30 orangepizero volumio[1027]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1303:35) Nov 23 16:09:30 orangepizero volumio[1027]: at Socket.emit (events.js:400:28) Nov 23 16:09:30 orangepizero volumio[1027]: at addChunk (internal/streams/readable.js:293:12) Nov 23 16:09:30 orangepizero volumio[1027]: at readableAddChunk (internal/streams/readable.js:267:9) Nov 23 16:09:30 orangepizero volumio[1027]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 16:09:31 orangepizero go-librespot[1255]: time="2024-11-23T16:09:31+01:00" level=debug msg="handling resume player command from e7a02be3ba883fa6873290af120bcfcf3e65b0d3" Nov 23 16:09:31 orangepizero go-librespot[1255]: time="2024-11-23T16:09:31+01:00" level=trace msg="seek to 841ms (diff: 201ms, samples: 37088, bytes: 22034)" Nov 23 16:09:31 orangepizero go-librespot[1255]: time="2024-11-23T16:09:31+01:00" level=debug msg="resume track at 269ms" Nov 23 16:09:31 orangepizero go-librespot[1255]: time="2024-11-23T16:09:31+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 23 16:09:31 orangepizero go-librespot[1255]: time="2024-11-23T16:09:31+01:00" level=debug msg="sending successful reply for delaer request" Nov 23 16:09:31 orangepizero go-librespot[1255]: time="2024-11-23T16:09:31+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 23 16:09:31 orangepizero go-librespot[1255]: time="2024-11-23T16:09:31+01:00" level=trace msg="emitting websocket event: playing" Nov 23 16:09:33 orangepizero sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-23 16:08 Nov 23 16:09:33 orangepizero sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 10:15:17 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="49ee0b71bdee95489f79b31a5db4cbdb"