-- Logs begin at Tue 2023-08-29 15:57:00 UTC, end at Tue 2023-08-29 15:58:05 UTC. -- Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys cpuset Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys cpu Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys cpuacct Aug 29 15:57:00 volumio kernel: Linux version 3.16.85 (odroidc2@busteros) (gcc version 4.9.2 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) ) #5 SMP PREEMPT Wed Jan 27 11:35:54 CET 2021 Aug 29 15:57:00 volumio kernel: CPU: AArch64 Processor [410fd034] revision 4 Aug 29 15:57:00 volumio kernel: secmon: share mem setup Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,secmon, compatible id aml_secmon_memory Aug 29 15:57:00 volumio kernel: __reserved_mem_alloc_size: linux,meson-fb Aug 29 15:57:00 volumio kernel: fb: Reserved memory: created fb at 0x0000000078000000, size 128 MiB Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,meson-fb, compatible id amlogic, fb-memory Aug 29 15:57:00 volumio kernel: __reserved_mem_alloc_size: linux,di Aug 29 15:57:00 volumio kernel: DI reserved memory: created CMA memory pool at 0x0000000076200000, size 30 MiB Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,di, compatible id amlogic, di-mem Aug 29 15:57:00 volumio kernel: __reserved_mem_alloc_size: linux,ion-dev Aug 29 15:57:00 volumio kernel: linux,ion-dev add multi user:ffffffc001cf7ee8 Aug 29 15:57:00 volumio kernel: ion_dev mem setup Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,ion-dev, compatible id amlogic, idev-mem Aug 29 15:57:00 volumio kernel: ppmgr share mem setup Aug 29 15:57:00 volumio kernel: linux,ion-dev add multi user:ffffffc001cfd388 Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,ion-dev, compatible id amlogic, idev-mem Aug 29 15:57:00 volumio kernel: __reserved_mem_alloc_size: linux,codec_mm_cma Aug 29 15:57:00 volumio kernel: Reserved memory: created CMA memory pool at 0x0000000067c00000, size 188 MiB Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,codec_mm_cma, compatible id shared-dma-pool Aug 29 15:57:00 volumio kernel: __reserved_mem_alloc_size: linux,picdec Aug 29 15:57:00 volumio kernel: Reserved memory: created CMA memory pool at 0x0000000064c00000, size 48 MiB Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,picdec, compatible id shared-dma-pool Aug 29 15:57:00 volumio kernel: __reserved_mem_alloc_size: linux,codec_mm_reserved Aug 29 15:57:00 volumio kernel: codec_mm:vdec: reserved mem setup Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,codec_mm_reserved, compatible id amlogic, codec-mm-reserved Aug 29 15:57:00 volumio kernel: __reserved_mem_alloc_size: linux,jpegenc_cma Aug 29 15:57:00 volumio kernel: Reserved memory: created CMA memory pool at 0x000000005e400000, size 36 MiB Aug 29 15:57:00 volumio kernel: Reserved memory: initialized node linux,jpegenc_cma, compatible id shared-dma-pool Aug 29 15:57:00 volumio kernel: cma: CMA: reserved 8 MiB at 5dc00000 Aug 29 15:57:00 volumio kernel: On node 0 totalpages: 486912 Aug 29 15:57:00 volumio kernel: Normal zone: 6664 pages used for memmap Aug 29 15:57:00 volumio kernel: Normal zone: 0 pages reserved Aug 29 15:57:00 volumio kernel: Normal zone: 486912 pages, LIFO batch:31 Aug 29 15:57:00 volumio kernel: psci: probing for conduit method from DT. Aug 29 15:57:00 volumio kernel: psci: Using PSCI v0.1 Function IDs from DT Aug 29 15:57:00 volumio kernel: PERCPU: Embedded 12 pages/cpu s19712 r8192 d21248 u49152 Aug 29 15:57:00 volumio kernel: pcpu-alloc: s19712 r8192 d21248 u49152 alloc=12*4096 Aug 29 15:57:00 volumio kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 29 15:57:00 volumio kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 480248 Aug 29 15:57:00 volumio kernel: Kernel command line: imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait ro console=ttyS0,115200n8 console=tty0 no_console_suspend hdmimode=1080p60hz m_bpp=32 vout= fsck.repair=yes net.ifnames=0 elevator=noop disablehpd=true max_freq=1536 maxcpus=4 monitor_onoff=false Aug 29 15:57:00 volumio kernel: logo: get hdmimode: 1080p60hz Aug 29 15:57:00 volumio kernel: dvfs [get_max_freq] - max_freq : 1536000000 Aug 29 15:57:00 volumio kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Aug 29 15:57:00 volumio kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) Aug 29 15:57:00 volumio kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) Aug 29 15:57:00 volumio kernel: Memory: 1475992K/1947648K available (8149K kernel code, 878K rwdata, 3024K rodata, 923K init, 4108K bss, 471656K reserved) Aug 29 15:57:00 volumio kernel: Virtual kernel memory layout: vmalloc : 0xffffff8000000000 - 0xffffffbbffff0000 (245759 MB) vmemmap : 0xffffffbc00000000 - 0xffffffbc01a40000 ( 26 MB) modules : 0xffffffbffc000000 - 0xffffffc000000000 ( 64 MB) memory : 0xffffffc000000000 - 0xffffffc078000000 ( 1920 MB) .init : 0xffffffc001b6b000 - 0xffffffc001c51d00 ( 924 kB) .text : 0xffffffc001080000 - 0xffffffc001b6a6c4 ( 11178 kB) .data : 0xffffffc001c52000 - 0xffffffc001d2d930 ( 879 kB) Aug 29 15:57:00 volumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 29 15:57:00 volumio kernel: Preemptible hierarchical RCU implementation. Aug 29 15:57:00 volumio kernel: NR_IRQS:64 nr_irqs:64 0 Aug 29 15:57:00 volumio kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483648000ns Aug 29 15:57:00 volumio kernel: mclk->mux_reg =ffffff8000002990,mclk->reg =ffffff800000a994 Aug 29 15:57:00 volumio kernel: local timer MESON TIMER-G mclk->mux_reg =ffffff8000002990,mclk->reg =ffffff800000c998 Aug 29 15:57:00 volumio kernel: local timer MESON TIMER-H mclk->mux_reg =ffffff8000002990,mclk->reg =ffffff800000e99c Aug 29 15:57:00 volumio kernel: local timer MESON TIMER-I mclk->mux_reg =ffffff8000002990,mclk->reg =ffffff80000109a0 Aug 29 15:57:00 volumio kernel: Switching to timer-based delay loop Aug 29 15:57:00 volumio kernel: Console: colour dummy device 80x25 Aug 29 15:57:00 volumio kernel: console [tty0] enabled Aug 29 15:57:00 volumio kernel: allocated 8388608 bytes of page_cgroup Aug 29 15:57:00 volumio kernel: please try 'cgroup_disable=memory' option if you don't want memory cgroups Aug 29 15:57:00 volumio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2.00 BogoMIPS (lpj=10000) Aug 29 15:57:00 volumio kernel: pid_max: default: 32768 minimum: 301 Aug 29 15:57:00 volumio kernel: Security Framework initialized Aug 29 15:57:00 volumio kernel: AppArmor: AppArmor initialized Aug 29 15:57:00 volumio kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) Aug 29 15:57:00 volumio kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys memory Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys devices Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys freezer Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys net_cls Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys blkio Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys perf_event Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys net_prio Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys hugetlb Aug 29 15:57:00 volumio kernel: Initializing cgroup subsys debug Aug 29 15:57:00 volumio kernel: ftrace: allocating 30065 entries in 118 pages Aug 29 15:57:00 volumio kernel: hw perfevents: enabled with arm/armv8-pmuv3 PMU driver, 7 counters available Aug 29 15:57:00 volumio kernel: Meson chip version = RevC (1F:C - 0:0) Aug 29 15:57:00 volumio kernel: CPU1: Booted secondary processor Aug 29 15:57:00 volumio kernel: CPU2: Booted secondary processor Aug 29 15:57:00 volumio kernel: CPU3: Booted secondary processor Aug 29 15:57:00 volumio kernel: Brought up 4 CPUs Aug 29 15:57:00 volumio kernel: SMP: Total of 4 processors activated. Aug 29 15:57:00 volumio kernel: devtmpfs: initialized Aug 29 15:57:00 volumio kernel: futex hash table entries: 1024 (order: 4, 65536 bytes) Aug 29 15:57:00 volumio kernel: pinctrl core: initialized pinctrl subsystem Aug 29 15:57:00 volumio kernel: regulator-dummy: no parameters Aug 29 15:57:00 volumio kernel: device-tree: Duplicate name in efusekey, renamed to "key0#1" Aug 29 15:57:00 volumio kernel: device-tree: Duplicate name in efusekey, renamed to "key1#1" Aug 29 15:57:00 volumio kernel: device-tree: Duplicate name in efusekey, renamed to "key2#1" Aug 29 15:57:00 volumio kernel: device-tree: Duplicate name in efusekey, renamed to "key3#1" Aug 29 15:57:00 volumio kernel: NET: Registered protocol family 16 Aug 29 15:57:00 volumio kernel: register canvas platform driver Aug 29 15:57:00 volumio kernel: codec:ignore bus ops for cpu=25 Aug 29 15:57:00 volumio kernel: codec:ignore bus ops for cpu=29 Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[0] Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[4] Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[3] Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[2] Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[1] Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[13] Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[2] Aug 29 15:57:00 volumio kernel: codec:register amports ops for bus[14] Aug 29 15:57:00 volumio kernel: register rdma platform driver Aug 29 15:57:00 volumio kernel: vdso: 2 pages (1 code, 1 data) at base ffffffc001c5a000 Aug 29 15:57:00 volumio kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 29 15:57:00 volumio kernel: DMA: preallocated 256 KiB pool for atomic allocations Aug 29 15:57:00 volumio kernel: software IO TLB: mapped [mem 0x5ac00000-0x5b000000] (4MB) Aug 29 15:57:00 volumio kernel: Serial: AMBA PL011 UART driver Aug 29 15:57:00 volumio kernel: hdmitx: system: amhdmitx_init Aug 29 15:57:00 volumio kernel: hdmitx: system: Ver: 2014May6 Aug 29 15:57:00 volumio kernel: tv_vout: tv_init_module Aug 29 15:57:00 volumio kernel: tv_vout: major number 254 for disp Aug 29 15:57:00 volumio kernel: vout_notify: vout_register_server Aug 29 15:57:00 volumio kernel: tv_vout: register tv module server ok Aug 29 15:57:00 volumio kernel: codec_mm:codec_mm_module_init Aug 29 15:57:00 volumio kernel: gxbb clk HIU base is 0xffffff8000058000 Aug 29 15:57:00 volumio kernel: gxbb clk ao base is 0xffffff800005a000 Aug 29 15:57:00 volumio kernel: register mpll_clk_out0 success done Aug 29 15:57:00 volumio kernel: register mpll_clk_out1 success done Aug 29 15:57:00 volumio kernel: register mpll_clk_out2 success done Aug 29 15:57:00 volumio kernel: register sys pll success done Aug 29 15:57:00 volumio kernel: clkrate [ xtal ] : 24000000Hz Aug 29 15:57:00 volumio kernel: clkrate [ 32Khz ] : 32000Hz Aug 29 15:57:00 volumio kernel: clkrate [ clk81 ] : 166666666Hz Aug 29 15:57:00 volumio kernel: clkrate [ fixed_pll ] : 2000000000Hz Aug 29 15:57:00 volumio kernel: clkrate [ fclk_div2 ] : 1000000000Hz Aug 29 15:57:00 volumio kernel: clkrate [ fclk_div3 ] : 666666000Hz Aug 29 15:57:00 volumio kernel: clkrate [ fclk_div4 ] : 500000000Hz Aug 29 15:57:00 volumio kernel: clkrate [ fclk_div5 ] : 400000000Hz Aug 29 15:57:00 volumio kernel: clkrate [ fclk_div7 ] : 285714000Hz Aug 29 15:57:00 volumio kernel: gxbb clock initialization complete Aug 29 15:57:00 volumio kernel: msr_clk_reg0=ffffff800005c75c,msr_clk_reg2=ffffff800005e764 Aug 29 15:57:00 volumio kernel: amlogic iomap probe done Aug 29 15:57:00 volumio kernel: Init pinux probe! Aug 29 15:57:00 volumio kernel: pinmux-gxbb c1109880.pinmux: Probed amlogic pinctrl driver Aug 29 15:57:00 volumio kernel: genirq: Setting trigger mode 8 for irq 241 failed (gic_set_type+0x0/0x14c) Aug 29 15:57:00 volumio kernel: genirq: Setting trigger mode 8 for irq 242 failed (gic_set_type+0x0/0x14c) Aug 29 15:57:00 volumio kernel: genirq: Setting trigger mode 8 for irq 241 failed (gic_set_type+0x0/0x14c) Aug 29 15:57:00 volumio kernel: genirq: Setting trigger mode 8 for irq 242 failed (gic_set_type+0x0/0x14c) Aug 29 15:57:00 volumio kernel: dvfs [scpi_dvfs_get_opps] - new count 6, max_freq 1536000000 Aug 29 15:57:00 volumio kernel: codec:codec map io source 0x00000000c1100000,size=1048576 to 0xffffff8000680000 Aug 29 15:57:00 volumio kernel: codec:codec map io source 0x00000000c8820000,size=65536 to 0xffffff80000a0000 Aug 29 15:57:00 volumio kernel: codec:codec map io source 0x00000000c883c000,size=8192 to 0xffffff8000094000 Aug 29 15:57:00 volumio kernel: codec:codec map io source 0x00000000c8100000,size=1048576 to 0xffffff8000800000 Aug 29 15:57:00 volumio kernel: codec:codec map io source 0x00000000d0100000,size=262144 to 0xffffff8000980000 Aug 29 15:57:00 volumio kernel: codec:codec map io source 0x00000000c8838000,size=1024 to 0xffffff800007e000 Aug 29 15:57:00 volumio kernel: codec_mm has 2 memory regions Aug 29 15:57:00 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma ok Aug 29 15:57:00 volumio kernel: codec_mm:codec_mm_reserved_init 0000000060b00000->0000000064c00000 Aug 29 15:57:00 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_reserved ok Aug 29 15:57:00 volumio kernel: codec_mm:codec_mm_probe mem init done Aug 29 15:57:00 volumio kernel: codec_mm:add reserve memory 0000000060b00000(aligned 0000000060b00000) size=4100000(aligned 4100000) Aug 29 15:57:00 volumio kernel: codec_mm has 2 memory regions Aug 29 15:57:00 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma ok Aug 29 15:57:00 volumio kernel: codec_mm:codec_mm_reserved_init 0000000060b00000->0000000064c00000 Aug 29 15:57:00 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_reserved ok Aug 29 15:57:00 volumio kernel: codec_mm:codec_mm reserved memory probed done Aug 29 15:57:00 volumio kernel: codec_mm:codec_mm_probe ok Aug 29 15:57:00 volumio kernel: VPU driver version: v01 Aug 29 15:57:00 volumio kernel: vpu driver detect cpu type: gxbaby Aug 29 15:57:00 volumio kernel: load vpu_clk in dts: 666667000Hz(7) Aug 29 15:57:00 volumio kernel: vpu_probe OK Aug 29 15:57:00 volumio kernel: hdmitx: system: amhdmitx_probe Aug 29 15:57:00 volumio kernel: hdmitx hpd irq = 89 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xc0800000 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xc1104400 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xc8100000 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xc8834000 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xc883a000 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xc883c000 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xd0100000 Aug 29 15:57:00 volumio kernel: hdmitx20: Mapped PHY: 0xda83a000 Aug 29 15:57:00 volumio kernel: hdmitx: alread display in uboot 0x10 Aug 29 15:57:00 volumio kernel: avmute set to 1 Aug 29 15:57:00 volumio kernel: canvas_probe reg=00000000c8838000,size=400 Aug 29 15:57:00 volumio kernel: canvas maped reg_base =ffffff80000b2000 Aug 29 15:57:00 volumio kernel: rdma_probe Aug 29 15:57:00 volumio kernel: SCSI subsystem initialized Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver usbfs Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver hub Aug 29 15:57:00 volumio kernel: usbcore: registered new device driver usb Aug 29 15:57:00 volumio kernel: media: Linux media interface: v0.10 Aug 29 15:57:00 volumio kernel: Linux video capture interface: v2.00 Aug 29 15:57:00 volumio kernel: pps_core: LinuxPPS API ver. 1 registered Aug 29 15:57:00 volumio kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Aug 29 15:57:00 volumio kernel: PTP clock support registered Aug 29 15:57:00 volumio kernel: logo: logo_init Aug 29 15:57:00 volumio kernel: Advanced Linux Sound Architecture Driver Initialized. Aug 29 15:57:00 volumio kernel: Bluetooth: Core ver 2.19 Aug 29 15:57:00 volumio kernel: NET: Registered protocol family 31 Aug 29 15:57:00 volumio kernel: Bluetooth: HCI device and connection manager initialized Aug 29 15:57:00 volumio kernel: Bluetooth: HCI socket layer initialized Aug 29 15:57:00 volumio kernel: Bluetooth: L2CAP socket layer initialized Aug 29 15:57:00 volumio kernel: Bluetooth: SCO socket layer initialized Aug 29 15:57:00 volumio kernel: NetLabel: Initializing Aug 29 15:57:00 volumio kernel: NetLabel: domain hash size = 128 Aug 29 15:57:00 volumio kernel: NetLabel: protocols = UNLABELED CIPSOv4 Aug 29 15:57:00 volumio kernel: NetLabel: unlabeled traffic allowed by default Aug 29 15:57:00 volumio kernel: Switched to clocksource Timer-E Aug 29 15:57:00 volumio kernel: AppArmor: AppArmor Filesystem Enabled Aug 29 15:57:00 volumio kernel: NET: Registered protocol family 2 Aug 29 15:57:00 volumio kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes) Aug 29 15:57:00 volumio kernel: TCP bind hash table entries: 16384 (order: 6, 262144 bytes) Aug 29 15:57:00 volumio kernel: TCP: Hash tables configured (established 16384 bind 16384) Aug 29 15:57:00 volumio kernel: TCP: reno registered Aug 29 15:57:00 volumio kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes) Aug 29 15:57:00 volumio kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes) Aug 29 15:57:00 volumio kernel: NET: Registered protocol family 1 Aug 29 15:57:00 volumio kernel: RPC: Registered named UNIX socket transport module. Aug 29 15:57:00 volumio kernel: RPC: Registered udp transport module. Aug 29 15:57:00 volumio kernel: RPC: Registered tcp transport module. Aug 29 15:57:00 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 29 15:57:00 volumio kernel: Unpacking initramfs... Aug 29 15:57:00 volumio kernel: Freeing initrd memory: 5528K (ffffffc0739cd000 - ffffffc073f33000) Aug 29 15:57:00 volumio kernel: kvm [1]: Using HYP init bounce page @5aa0d000 Aug 29 15:57:00 volumio kernel: kvm [1]: interrupt-controller@c4304000 IRQ25 Aug 29 15:57:00 volumio kernel: kvm [1]: kvm_arch_timer: can't find DT node Aug 29 15:57:00 volumio kernel: kvm [1]: error initializing Hyp mode: -19 Aug 29 15:57:00 volumio kernel: audit: initializing netlink subsys (disabled) Aug 29 15:57:00 volumio kernel: audit: type=2000 audit(0.430:1): initialized Aug 29 15:57:00 volumio kernel: HugeTLB registered 2 MB page size, pre-allocated 0 pages Aug 29 15:57:00 volumio kernel: VFS: Disk quotas dquot_6.5.2 Aug 29 15:57:00 volumio kernel: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 29 15:57:00 volumio kernel: NFS: Registering the id_resolver key type Aug 29 15:57:00 volumio kernel: Key type id_resolver registered Aug 29 15:57:00 volumio kernel: Key type id_legacy registered Aug 29 15:57:00 volumio kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Aug 29 15:57:00 volumio kernel: msgmni has been set to 3453 Aug 29 15:57:00 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Aug 29 15:57:00 volumio kernel: io scheduler noop registered (default) Aug 29 15:57:00 volumio kernel: io scheduler deadline registered Aug 29 15:57:00 volumio kernel: io scheduler cfq registered Aug 29 15:57:00 volumio kernel: meson-rng c8834000.rng: hwrng registered Aug 29 15:57:00 volumio kernel: enter cpufreq Aug 29 15:57:00 volumio kernel: probe cpufreq okay Aug 29 15:57:00 volumio kernel: dvfs [scpi_dvfs_get_opps] - new count 6, max_freq 1536000000 Aug 29 15:57:00 volumio kernel: aml-thermal aml-sensor@0: min state:500000 400 1 2 Aug 29 15:57:00 volumio kernel: aml-thermal aml-sensor@0: gpu coef:437, pp:3 Aug 29 15:57:00 volumio kernel: aml-thermal aml-sensor@0: cdev1 set upper to 3 Aug 29 15:57:00 volumio kernel: aml-thermal aml-sensor@0: cdev2 set upper to 3 Aug 29 15:57:00 volumio kernel: aml-thermal aml-sensor@0: cdev0 set upper to 3 Aug 29 15:57:00 volumio kernel: [drm] Initialized drm 1.1.0 20060810 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: max pp is 3 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: min pp is 3 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: min clk is 4 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: hiu io source 0xffffff80000e4000 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: hiu io source 0xffffff80000e6000 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: num of pp used most of time 3 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: clock dvfs table size is 6 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: max clk set 4 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: max clk is 4 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: turbo clk set to 5 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: turbo clk is 5 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: default clk is 4 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: ====================0==================== clk_freq= 125000000, clk_parent=fclk_div4, voltage=1150, keep_count=5, threshod=<30 120>, clk_sample=125 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: ====================1==================== clk_freq= 285000000, clk_parent=fclk_div7, voltage=1150, keep_count=5, threshod=<100 190>, clk_sample=285 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: ====================2==================== clk_freq= 400000000, clk_parent=fclk_div5, voltage=1150, keep_count=5, threshod=<152 207>, clk_sample=400 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: ====================3==================== clk_freq= 500000000, clk_parent=fclk_div4, voltage=1150, keep_count=5, threshod=<180 220>, clk_sample=500 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: ====================4==================== clk_freq= 666000000, clk_parent=fclk_div3, voltage=1150, keep_count=5, threshod=<210 236>, clk_sample=666 Aug 29 15:57:00 volumio kernel: mali-utgard d00c0000.mali: ====================5==================== clk_freq= 792000000, clk_parent= gp0_pll, voltage=1150, keep_count=5, threshod=<230 255>, clk_sample=792 Aug 29 15:57:00 volumio kernel: cdev3 set upper to 2 Aug 29 15:57:00 volumio kernel: cdev4 set upper to 2 Aug 29 15:57:00 volumio kernel: gpu cooling register okay with err=0 Aug 29 15:57:00 volumio kernel: cdev5 set upper to 1 Aug 29 15:57:00 volumio kernel: gpu core cooling register okay with err=0 Aug 29 15:57:00 volumio kernel: Mali: Mali device driver loaded Aug 29 15:57:00 volumio kernel: UMP: UMP device driver -21a239a0 loaded Aug 29 15:57:00 volumio kernel: loop: module loaded Aug 29 15:57:00 volumio kernel: mtdoops: mtd device (mtddev=name/number) must be supplied Aug 29 15:57:00 volumio kernel: stmmac - user ID: 0x11, Synopsys ID: 0x37 Aug 29 15:57:00 volumio kernel: Ring mode enabled Aug 29 15:57:00 volumio kernel: DMA HW capability register supported Aug 29 15:57:00 volumio kernel: Normal descriptors Aug 29 15:57:00 volumio kernel: RX Checksum Offload Engine supported (type 2) Aug 29 15:57:00 volumio kernel: TX Checksum insertion supported Aug 29 15:57:00 volumio kernel: Wake-Up On Lan supported Aug 29 15:57:00 volumio kernel: Enable RX Mitigation via HW Watchdog Timer Aug 29 15:57:00 volumio kernel: hdmitx: plugin Aug 29 15:57:00 volumio kernel: hdmitx: system: irq 80000001 Aug 29 15:57:00 volumio kernel: libphy: stmmac: probed Aug 29 15:57:00 volumio kernel: eth0: PHY ID 001cc916 at 0 IRQ POLL (stmmac-0:00) active Aug 29 15:57:00 volumio kernel: eth0: PHY ID 001cc916 at 7 IRQ POLL (stmmac-0:07) Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver cdc_ether Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver cdc_ncm Aug 29 15:57:00 volumio kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Aug 29 15:57:00 volumio kernel: ehci-h20ahb: H20AHB-EHCI Host Controller driver Aug 29 15:57:00 volumio kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver cdc_acm Aug 29 15:57:00 volumio kernel: cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver usb-storage Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver usbserial Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver usbserial_generic Aug 29 15:57:00 volumio kernel: usbserial: USB Serial support registered for generic Aug 29 15:57:00 volumio kernel: mousedev: PS/2 mouse device common for all mice Aug 29 15:57:00 volumio kernel: i2c /dev entries driver Aug 29 15:57:00 volumio kernel: IR Sharp protocol handler initialized Aug 29 15:57:00 volumio kernel: Bluetooth: HCI UART driver ver 2.2 Aug 29 15:57:00 volumio kernel: Bluetooth: HCI H4 protocol initialized Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver btusb Aug 29 15:57:00 volumio kernel: Bluetooth: Generic Bluetooth SDIO driver ver 0.1 Aug 29 15:57:00 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Aug 29 15:57:00 volumio kernel: hidraw: raw HID events driver (C) Jiri Kosina Aug 29 15:57:00 volumio kernel: usbcore: registered new interface driver usbhid Aug 29 15:57:00 volumio kernel: usbhid: USB HID core driver Aug 29 15:57:00 volumio kernel: ==uart0 reg addr = ffffff80002344c0 Aug 29 15:57:00 volumio kernel: c81004c0.serial: ttyS0 at MMIO 0xc81004c0 (irq = 225, base_baud = 1500000) is a meson_uart Aug 29 15:57:00 volumio kernel: hdmitx: edid: raw data are all zeroes Aug 29 15:57:00 volumio kernel: EDID Parser: Aug 29 15:57:00 volumio kernel: EDID BlockCount=0 Aug 29 15:57:00 volumio kernel: hdmitx: edid: HDMI: set default vic Aug 29 15:57:00 volumio kernel: hdmitx: video: get current mode: null Aug 29 15:57:00 volumio kernel: hdmtix: set audio Aug 29 15:57:00 volumio kernel: hdmitx tx_aud_src = 0 Aug 29 15:57:00 volumio kernel: hdmitx aud_n_para = 24576 Aug 29 15:57:00 volumio kernel: hdmitx set channel status Aug 29 15:57:00 volumio kernel: console [ttyS0] enabled Aug 29 15:57:00 volumio kernel: ==uart1 reg addr = ffffff80002364c0 Aug 29 15:57:00 volumio kernel: c11084c0.serial: ttyS1 at MMIO 0xc11084c0 (irq = 58, base_baud = 1500000) is a meson_uart Aug 29 15:57:00 volumio kernel: dwc_otg: usb1: type: 1 speed: 0, config: 0, dma: 0, id: 1, phy: c0000020, ctrl: 0 Aug 29 15:57:00 volumio kernel: dwc_otg: Core Release: 3.10a Aug 29 15:57:00 volumio kernel: dwc_otg: Setting default values for core params Aug 29 15:57:00 volumio kernel: dwc_otg: curmode: 1, host_only: 1 Aug 29 15:57:00 volumio kernel: dwc_otg: Using Buffer DMA mode Aug 29 15:57:00 volumio kernel: dwc_otg: OTG VER PARAM: 1, OTG VER FLAG: 1 Aug 29 15:57:00 volumio kernel: dwc_otg: Working on port type = HOST Aug 29 15:57:00 volumio kernel: dwc_otg dwc2_b: DWC OTG Controller Aug 29 15:57:00 volumio kernel: dwc_otg dwc2_b: new USB bus registered, assigned bus number 1 Aug 29 15:57:00 volumio kernel: dwc_otg dwc2_b: irq 63, io mem 0x00000000 Aug 29 15:57:00 volumio kernel: dwc_otg: -------hcd->flags.d32 = 0 Aug 29 15:57:00 volumio kernel: dwc_otg: Init: Port Power? op_state=1 Aug 29 15:57:00 volumio kernel: dwc_otg: Init1: Power Port (0) Aug 29 15:57:00 volumio kernel: hub 1-0:1.0: USB hub found Aug 29 15:57:00 volumio kernel: hub 1-0:1.0: 1 port detected Aug 29 15:57:00 volumio kernel: dwc_otg: usb0: type: 0 speed: 0, config: 0, dma: 0, id: 0, phy: c0000000, ctrl: 0 Aug 29 15:57:00 volumio kernel: dwc_otg: Core Release: 3.10a Aug 29 15:57:00 volumio kernel: dwc_otg: Setting default values for core params Aug 29 15:57:00 volumio kernel: dwc_otg: curmode: 1, host_only: 0 Aug 29 15:57:00 volumio kernel: dwc_otg: Using Buffer DMA mode Aug 29 15:57:00 volumio kernel: dwc_otg: OTG VER PARAM: 1, OTG VER FLAG: 1 Aug 29 15:57:00 volumio kernel: dwc_otg: Working on port type = OTG Aug 29 15:57:00 volumio kernel: dwc_otg: Current port type: SLAVE Aug 29 15:57:00 volumio kernel: dwc_otg dwc2_a: DWC OTG Controller Aug 29 15:57:00 volumio kernel: dwc_otg dwc2_a: new USB bus registered, assigned bus number 2 Aug 29 15:57:00 volumio kernel: dwc_otg dwc2_a: irq 62, io mem 0x00000000 Aug 29 15:57:00 volumio kernel: hub 2-0:1.0: USB hub found Aug 29 15:57:00 volumio kernel: hub 2-0:1.0: 1 port detected Aug 29 15:57:00 volumio kernel: dwc_otg: Dedicated Tx FIFOs mode Aug 29 15:57:00 volumio kernel: dwc_otg: using timer detectid change, ffffffc05a943800 Aug 29 15:57:00 volumio kernel: fb: osd_init_module Aug 29 15:57:00 volumio kernel: fb: viu vsync irq: 35 Aug 29 15:57:00 volumio kernel: meson-fb has 1 memory regions Aug 29 15:57:00 volumio kernel: meson-fb meson-fb: assigned reserved memory node linux,meson-fb ok Aug 29 15:57:00 volumio kernel: logo: get initial logo vmode: 1080p60hz Aug 29 15:57:00 volumio kernel: tv_vout: tv_set_current_vmode[707]fps_target_mode=12 Aug 29 15:57:00 volumio kernel: tv_vout: mode is 12,sync_duration_den=1,sync_duration_num=60 Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: vencp ON Aug 29 15:57:00 volumio kernel: tv_vout: TV mode 1080p60hz selected. Aug 29 15:57:00 volumio kernel: tv_vout: new mode =1080p60hz set ok Aug 29 15:57:00 volumio kernel: vout_serve: vinfo mode is: 1080p60hz Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: viu_osd1 ON Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: viu_osd2 ON Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: viu_osd_scale ON Aug 29 15:57:00 volumio kernel: osd_rdma: osd_rdma_init: rmda_table p=0x5dc49000,op=0x5dc49000 , v=0xffffff8000266000 Aug 29 15:57:00 volumio kernel: hdmitx: video: get current mode: 1080p60hz Aug 29 15:57:00 volumio kernel: hdmitx: video: get current mode: 1080p60hz Aug 29 15:57:00 volumio kernel: hdmitx: system: [set_disp_mode_auto] ALREADY init VIC = 16 Aug 29 15:57:00 volumio kernel: hdmitx: system: change to HDMI mode Aug 29 15:57:00 volumio kernel: fb: validating vinfo tables Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc phy 27000 vid 54000 enc 27000 pix 27000 clocks not equal Aug 29 15:57:00 volumio kernel: fb: vinfo 0 480i60hz, hdmi 7 720x480i60hz, 720x480-60 4:3 27000 Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 1 480i_rpt, 720x480-60 4:3 27000, hdmi 11 no para Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 2 480cvbs, 720x480-60 4:3 27000, no hdmi vic Aug 29 15:57:00 volumio kernel: dwc_otg: Indeed it is in host mode hprt0 = 00021501 Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 4 480p_rpt, 720x480-60 4:3 27000, hdmi 36 no para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc phy 27000 vid 54000 enc 27000 pix 27000 clocks not equal Aug 29 15:57:00 volumio kernel: fb: vinfo 5 576i50hz, hdmi 22 720x576i50hz, 720x576-50 4:3 27000 Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 6 576i_rpt, 720x576-50 4:3 27000, hdmi 26 no para Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 7 576cvbs, 720x576-50 4:3 27000, no hdmi vic Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 9 576p_rpt, 720x576-50 4:3 27000, hdmi 38 no para Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 23 4k2k5g, 3840x2160-50 16:9 495000, no hdmi vic Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 109 (0x000 + 109) no video para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc no clk for 109 hdmi Aug 29 15:57:00 volumio kernel: fb: info: used 3840x1080p120hz for 29 4k1k120hz Aug 29 15:57:00 volumio kernel: fb: vinfo 29 4k1k120hz, hdmi 109 3840x1080p120hz, 3840x1080-120 32:9 594000 Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 30 4k1k120hz420, 3840x1080-120 32:9 594000, no hdmi vic Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 110 (0x000 + 110) no video para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc no clk for 110 hdmi Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 3840x1080-50 594000 != 3840x1080-100 594000 vinfo Aug 29 15:57:00 volumio kernel: fb: info: used 3840x1080p100hz for 31 4k1k100hz Aug 29 15:57:00 volumio kernel: fb: vinfo 31 4k1k100hz, hdmi 110 3840x1080p100hz, 3840x1080-100 32:9 594000 Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 32 4k1k100hz420, 3840x1080-100 32:9 594000, no hdmi vic Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 33 4k05k240hz, 3840x1080-240 64:9 594000, no hdmi vic Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 34 4k05k240hz420, 3840x540-240 64:9 594000, no hdmi vic Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 35 4k05k200hz, 3840x540-200 64:9 594000, no hdmi vic Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 36 4k05k200hz420, 3840x1080-200 64:9 594000, no hdmi vic Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc 51830 != 51450 hdmi Aug 29 15:57:00 volumio kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg Aug 29 15:57:00 volumio kernel: fb: vinfo 41 1024x600p60hz, hdmi 772 1024x600p60hz, 1024x600-60 17:10 51450 Aug 29 15:57:00 volumio kernel: dwc_otg: Indeed Aug 29 15:57:00 volumio kernel: hdmitx: warning: 480x320p 800 263 0 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 480x320p 800 525 0 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: 100 120 95 8 100 4 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 100 120 189 8 100 8 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc TOTAL_LINES 263 != 320+107 (320+107) hdmi Aug 29 15:57:00 volumio kernel: fb: vinfo 56 480x320p60hz, hdmi 787 480x320p60hz, 480x320-60 3:2 25200 Aug 29 15:57:00 volumio kernel: hdmitx: warning: 480x272p 800 263 0 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 480x272p 800 525 0 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: 100 120 119 8 100 4 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 100 120 238 8 100 7 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc TOTAL_LINES 263 != 272+131 (272+131) hdmi Aug 29 15:57:00 volumio kernel: fb: vinfo 57 480x272p60hz, hdmi 788 480x272p60hz, 480x272-60 3:2 25200 Aug 29 15:57:00 volumio kernel: fb: warning: vinfo 62 wsxga, 1440x900-60 8:5 88750, no hdmi vic Aug 29 15:57:00 volumio kernel: hdmitx: warning: no tvenc for hdmi vic 790 Aug 29 15:57:00 volumio kernel: fb: vinfo 69 custombuilt, hdmi 790 custombuilt, 0x0-0 16:9 0 Aug 29 15:57:00 volumio kernel: fb: found 64 vinfos Aug 29 15:57:00 volumio kernel: fb: validating hdmi format tables Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 2 (0x000 + 2) no format para Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 6 (0x000 + 6) no format para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc phy 27000 vid 54000 enc 27000 pix 27000 clocks not equal Aug 29 15:57:00 volumio kernel: fb: info: hdmi 7 720x480i60hz, 1440x240-59 27000 Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 17 (0x000 + 17) no format para Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 21 (0x000 + 21) no format para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc phy 27000 vid 54000 enc 27000 pix 27000 clocks not equal Aug 29 15:57:00 volumio kernel: fb: info: hdmi 22 720x576i50hz, 1440x288-50 27000 Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 109 (0x000 + 109) no video para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc no clk for 109 hdmi Aug 29 15:57:00 volumio kernel: fb: info: hdmi 109 3840x1080p120hz, 3840x1080-120 594000 Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 110 (0x000 + 110) no video para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc no clk for 110 hdmi Aug 29 15:57:00 volumio kernel: fb: info: hdmi 110 3840x1080p100hz, 3840x1080-50 594000 Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 111 (0x000 + 111) no video para Aug 29 15:57:00 volumio kernel: hdmitx: warning: 3840x1080p 4400 562 0 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 3840x540p 4400 562 0 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc TOTAL_LINES 562 != 1080+22 (1080+22) hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc no clk for 111 hdmi Aug 29 15:57:00 volumio kernel: fb: info: hdmi 111 3840x540p240hz, 3840x540-120 594000 Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 112 (0x000 + 112) no video para Aug 29 15:57:00 volumio kernel: hdmitx: warning: 3840x1080p 5280 562 0 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 3840x540p 5280 562 0 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc TOTAL_LINES 562 != 1080+22 (1080+22) hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc no clk for 112 hdmi Aug 29 15:57:00 volumio kernel: fb: info: hdmi 112 3840x540p200hz, 3840x540-50 594000 Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 354 (0x100 + 98) no video para Aug 29 15:57:00 volumio kernel: fb: warning: hdmi 354 (0x100 + 98) no format para Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc 51830 != 51450 hdmi Aug 29 15:57:00 volumio kernel: fb: info: hdmi 772 1024x600p60hz, 1024x600-60 51450 Aug 29 15:57:00 volumio kernel: hdmitx: warning: 480x320p 800 263 0 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 480x320p 800 525 0 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: 100 120 95 8 100 4 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 100 120 189 8 100 8 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc TOTAL_LINES 263 != 320+107 (320+107) hdmi Aug 29 15:57:00 volumio kernel: fb: info: hdmi 787 480x320p60hz, 480x320-60 25200 Aug 29 15:57:00 volumio kernel: hdmitx: warning: 480x272p 800 263 0 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 480x272p 800 525 0 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: 100 120 119 8 100 4 tvenc != Aug 29 15:57:00 volumio kernel: hdmitx: 100 120 238 8 100 7 hdmi Aug 29 15:57:00 volumio kernel: hdmitx: warning: tvenc TOTAL_LINES 263 != 272+131 (272+131) hdmi Aug 29 15:57:00 volumio kernel: fb: info: hdmi 788 480x272p60hz, 480x272-60 25200 Aug 29 15:57:00 volumio kernel: fb: found 226 valid hdmi format parameters Aug 29 15:57:00 volumio kernel: fb: validation done. Aug 29 15:57:00 volumio kernel: fb: osd_probe vinfo:ffffffc001cf31c8 Aug 29 15:57:00 volumio kernel: fb: Frame buffer memory assigned at Aug 29 15:57:00 volumio kernel: fb: phy: 0x78000000, vir:0xffffff8001780000, size=98304K Aug 29 15:57:00 volumio kernel: fb: osd_set_res_bootargs : mode 12 Aug 29 15:57:00 volumio kernel: fb: hdmi vic for 12 1080p60hz is: 16 Aug 29 15:57:00 volumio kernel: fb: hdmi format para for 16 is: 16 1920x1080p60hz Aug 29 15:57:00 volumio kernel: fb: hdmi format para for 16 is: 16 1920x1080p60hz Aug 29 15:57:00 volumio kernel: fb: mode "1920x1080-60" Aug 29 15:57:00 volumio kernel: fb: # D: 148500, H: 67500, V: 60000 Aug 29 15:57:00 volumio kernel: fb: geometry 1920 1080 1920 2160 32 Aug 29 15:57:00 volumio kernel: fb: timings 6734 148 88 36 4 44 5 Aug 29 15:57:00 volumio kernel: fb: endmode Aug 29 15:57:00 volumio kernel: fb: fb def : 1920 1080 1920 2160 32 Aug 29 15:57:00 volumio kernel: fb: init fbdev bpp is:32 Aug 29 15:57:00 volumio kernel: fb: ---------------clear fb0 memory Aug 29 15:57:00 volumio kernel: it is in host mode Aug 29 15:57:00 volumio kernel: hprt0 = 00001101 Aug 29 15:57:00 volumio kernel: fb: osd[0] canvas.idx =0x40 Aug 29 15:57:00 volumio kernel: fb: osd[0] canvas.addr=0x78000000 Aug 29 15:57:00 volumio kernel: fb: osd[0] canvas.width=7680 Aug 29 15:57:00 volumio kernel: fb: osd[0] canvas.height=2160 Aug 29 15:57:00 volumio kernel: Console: switching Aug 29 15:57:00 volumio kernel: to colour frame buffer device 240x67 Aug 29 15:57:00 volumio kernel: fb: Frame buffer memory assigned at Aug 29 15:57:00 volumio kernel: fb: phy: 0x7e000000, vir:0xffffff8007800000, size=1024K Aug 29 15:57:00 volumio kernel: fb: osd probe OK Aug 29 15:57:00 volumio kernel: vout_serve: vout_init_module Aug 29 15:57:00 volumio kernel: vout_serve: meson_vout_probe Aug 29 15:57:00 volumio kernel: vout_serve: create vout attribute OK Aug 29 15:57:00 volumio kernel: ge2d: ge2d_init_module Aug 29 15:57:00 volumio kernel: ge2d: ge2d_dev major:241 Aug 29 15:57:00 volumio kernel: ge2d: ge2d clock is 400 MHZ Aug 29 15:57:00 volumio kernel: ge2d: ge2d: pdev=ffffffc05bf31000, irq=182, rstc=0xffffffc05abbcf00, clk=ffffffc05bf22480 Aug 29 15:57:00 volumio kernel: ge2d: mapped phy: 0xd0160000 Aug 29 15:57:00 volumio kernel: ge2d: ge2d start monitor Aug 29 15:57:00 volumio kernel: ge2d: ge2d workqueue monitor start Aug 29 15:57:00 volumio kernel: BLASTER Driver Init Aug 29 15:57:00 volumio kernel: secmon has 1 memory regions Aug 29 15:57:00 volumio kernel: secmon: share in base: 0xffffff8000268000, share out base: 0xffffff800026a000 Aug 29 15:57:00 volumio kernel: secmon secmon: assigned reserved memory node linux,secmon ok Aug 29 15:57:00 volumio kernel: secmon: probe done Aug 29 15:57:00 volumio kernel: storage: storage in base: 0xffffff8007980000 Aug 29 15:57:00 volumio kernel: storage: storage out base: 0xffffff8007a00000 Aug 29 15:57:00 volumio kernel: storage: storage block base: 0xffffff8007a80000 Aug 29 15:57:00 volumio kernel: storage: probe done! Aug 29 15:57:00 volumio kernel: aml_sd_emmc_probe: line 2898 Aug 29 15:57:00 volumio kernel: mmc driver version: 1.07, 2015-01-21: fix a bug in tuning which caused eMMC data CRC error Aug 29 15:57:00 volumio kernel: hub 1-1:1.0: USB hub found Aug 29 15:57:00 volumio kernel: hub 1-1:1.0: 4 ports detected Aug 29 15:57:00 volumio kernel: aml_sd_emmc_reg_init 621 Aug 29 15:57:00 volumio kernel: pdata->caps 60107 Aug 29 15:57:00 volumio kernel: pdata->caps2 0 Aug 29 15:57:00 volumio kernel: get property: ocr_avail, value:0x00200080 Aug 29 15:57:00 volumio kernel: get property: f_min, value:0x00061a80 Aug 29 15:57:00 volumio kernel: get property: f_max, value:0x0510ff40 Aug 29 15:57:00 volumio kernel: get property: max_req_size, value:0x00020000 Aug 29 15:57:00 volumio kernel: get property: irq_in, value:0x00000003 Aug 29 15:57:00 volumio kernel: get property: irq_out, value:0x00000005 Aug 29 15:57:00 volumio kernel: get property: power_level, value:0x00000001 Aug 29 15:57:00 volumio kernel: get property: gpio_cd, str: Aug 29 15:57:00 volumio kernel: get property: gpio_power, str: Aug 29 15:57:00 volumio kernel: get property: pinname, str:sd Aug 29 15:57:00 volumio kernel: get property: jtag_pin, str: Aug 29 15:57:00 volumio kernel: get property: card_type, value:0x00000005 Aug 29 15:57:00 volumio kernel: get property: gpio_dat3, str: Aug 29 15:57:00 volumio kernel: get property: gpio_volsw, str: Aug 29 15:57:00 volumio kernel: [aml_sd_emmc_probe] aml_sd_emmc_probe() success! Aug 29 15:57:00 volumio kernel: aml_sd_emmc_probe: line 2898 Aug 29 15:57:00 volumio kernel: [aml_is_card_insert] card IN Aug 29 15:57:00 volumio kernel: [aml_is_card_insert] card IN Aug 29 15:57:00 volumio kernel: aml_sd_emmc_reg_init 621 Aug 29 15:57:00 volumio kernel: pdata->caps 80000547 Aug 29 15:57:00 volumio kernel: pdata->caps2 a1 Aug 29 15:57:00 volumio kernel: get property: ocr_avail, value:0x00200080 Aug 29 15:57:00 volumio kernel: get property: f_min, value:0x00061a80 Aug 29 15:57:00 volumio kernel: get property: f_max, value:0x0bebc200 Aug 29 15:57:00 volumio kernel: get property: max_req_size, value:0x00020000 Aug 29 15:57:00 volumio kernel: get property: pinname, str:emmc Aug 29 15:57:00 volumio kernel: get property: card_type, value:0x00000001 Aug 29 15:57:00 volumio kernel: get property: gpio_dat3, str: Aug 29 15:57:00 volumio kernel: get property: hw_reset, str: Aug 29 15:57:00 volumio kernel: [aml_sd_emmc_probe] aml_sd_emmc_probe() success! Aug 29 15:57:00 volumio kernel: ion_dev has 1 memory regions Aug 29 15:57:00 volumio kernel: codec:Amlogic A/V streaming port init Aug 29 15:57:00 volumio kernel: codec:get gate demux control ok ffffffc05a032440 Aug 29 15:57:00 volumio kernel: codec:get gate parser_top control ok ffffffc05a0324c0 Aug 29 15:57:00 volumio kernel: codec:get gate vpu_intr control ok ffffffc05a032540 Aug 29 15:57:00 volumio kernel: codec:get gate vdec control ok ffffffc05a0325c0 Aug 29 15:57:00 volumio kernel: codec:[tsync_pcr_init]init success. Aug 29 15:57:00 volumio kernel: codec:regist mpeg12 codec profile Aug 29 15:57:00 volumio kernel: codec:regist mpeg4 codec profile Aug 29 15:57:00 volumio kernel: codec:amvdec_vc1 module init Aug 29 15:57:00 volumio kernel: codec:regist vc1 codec profile Aug 29 15:57:00 volumio kernel: codec:amvdec_h264 module init Aug 29 15:57:00 volumio kernel: codec:regist h264 codec profile Aug 29 15:57:00 volumio kernel: codec:amvdec_h264mvc module init Aug 29 15:57:00 volumio kernel: codec:regist hmvc codec profile Aug 29 15:57:00 volumio kernel: codec:amvdec_h264_4k2k module init Aug 29 15:57:00 volumio kernel: codec:regist h264_4k2k codec profile Aug 29 15:57:00 volumio kernel: codec:amvdec_h265 module init Aug 29 15:57:00 volumio kernel: codec:regist hevc codec profile Aug 29 15:57:00 volumio kernel: codec:regist mjpeg codec profile Aug 29 15:57:00 volumio kernel: codec:amvdec_real module init Aug 29 15:57:00 volumio kernel: codec:regist real codec profile Aug 29 15:57:00 volumio kernel: codec:amvdec_avs module init Aug 29 15:57:00 volumio kernel: codec:regist avs codec profile Aug 29 15:57:00 volumio kernel: amvenc_avc_probe -- reserved memory config fail. Aug 29 15:57:00 volumio kernel: amvenc_avc - cma memory pool size: 40 MB Aug 29 15:57:00 volumio kernel: encode_wq_init. Aug 29 15:57:00 volumio kernel: encode start monitor. Aug 29 15:57:00 volumio kernel: jpegenc module init Aug 29 15:57:00 volumio kernel: jpegenc probe start. Aug 29 15:57:00 volumio kernel: jpegenc has 1 memory regions Aug 29 15:57:00 volumio kernel: jpegenc jpegenc: assigned reserved memory node linux,jpegenc_cma ok Aug 29 15:57:00 volumio kernel: jpegenc - cma memory pool size: 36 MB Aug 29 15:57:00 volumio kernel: jpegenc memory config sucess, buff size is 0x2400000, level: 8M Aug 29 15:57:00 volumio kernel: jpegenc_wq_init. Aug 29 15:57:00 volumio kernel: jpegenc probe end. Aug 29 15:57:00 volumio kernel: codec:picdec_driver_probe called. Aug 29 15:57:00 volumio kernel: picdec has 1 memory regions Aug 29 15:57:00 volumio kernel: picdec picdec: assigned reserved memory node linux,picdec ok Aug 29 15:57:00 volumio kernel: codec:picdec_driver_probe done. Aug 29 15:57:00 volumio kernel: codec:reserved memory config fail , use CMA . Aug 29 15:57:00 volumio kernel: codec:cma memory is 64c00000 , size is 3000000 Aug 29 15:57:00 volumio kernel: codec:0 addr is 64c00000################ Aug 29 15:57:00 volumio kernel: codec:1 addr is 64efd000################ Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: vpu_arb ON Aug 29 15:57:00 volumio kernel: codec:create_ge2d_work_queue video task ok Aug 29 15:57:00 volumio kernel: encode workqueue monitor start. Aug 29 15:57:00 volumio kernel: codec:register clk_set_setting cpu[31] Aug 29 15:57:00 volumio kernel: di_module_init ok. Aug 29 15:57:00 volumio kernel: di_module_init: major 236 Aug 29 15:57:00 volumio kernel: di_probe Aug 29 15:57:00 volumio kernel: deinterlace has 1 memory regions Aug 29 15:57:00 volumio kernel: di reveser memory 0x76200000, size 30MB. Aug 29 15:57:00 volumio kernel: deinterlace deinterlace: assigned reserved memory node linux,di ok Aug 29 15:57:00 volumio kernel: rdma_register, rdma_table_addr ffffff8000481000 rdma_table_addr_phy 5dc4e000 reg_buf ffffffc05a0a4000 Aug 29 15:57:00 volumio kernel: rdma_register success, handle 1 table_size 8192 Aug 29 15:57:00 volumio kernel: di_probe allocate rdma channel 1. Aug 29 15:57:00 volumio kernel: DI hw version 2. Aug 29 15:57:00 volumio kernel: 0x000000c3:Y=c3,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000c4:Y=c4,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000c5:Y=c5,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000c6:Y=c6,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000c7:Y=c7,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000c8:Y=c8,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000c9:Y=c9,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000ca:Y=ca,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000cb:Y=cb,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000cc:Y=cc,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000cd:Y=cd,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000ce:Y=ce,U=0,V=0 Aug 29 15:57:00 volumio kernel: 0x000000cf:Y=cf,U=0,V=0 Aug 29 15:57:00 volumio kernel: di_probe here. Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: di_pre OFF Aug 29 15:57:00 volumio kernel: efusekeynum: 4 Aug 29 15:57:00 volumio kernel: efusekeyname: mac offset: 0 size: 6 Aug 29 15:57:00 volumio kernel: efusekeyname: mac_bt offset: 6 size: 6 Aug 29 15:57:00 volumio kernel: efusekeyname: mac_wifi offset: 12 size: 6 Aug 29 15:57:00 volumio kernel: efusekeyname: usid offset: 18 size: 16 Aug 29 15:57:00 volumio kernel: efuse efuse: probe OK! Aug 29 15:57:00 volumio kernel: [26B blob data] Aug 29 15:57:00 volumio kernel: ppmgr module init func called Aug 29 15:57:00 volumio kernel: ppmgr_driver_probe called Aug 29 15:57:00 volumio kernel: ppmgr has 1 memory regions Aug 29 15:57:00 volumio kernel: init ppmgr memsource 74200000->761fffff Aug 29 15:57:00 volumio kernel: ppmgr_probe done Aug 29 15:57:00 volumio kernel: ionvideo-000: V4L2 device registered as video13 Aug 29 15:57:00 volumio kernel: [dsp]register dsp to char divece(257) Aug 29 15:57:00 volumio kernel: amaudio: driver amaudio succuess! Aug 29 15:57:00 volumio kernel: amlvideo_init called Aug 29 15:57:00 volumio kernel: amlvideo_create_instance called Aug 29 15:57:00 volumio kernel: v4l2_dev.name=:amlvideo-000 Aug 29 15:57:00 volumio kernel: amlvideo-000: V4L2 device registered as video10 Aug 29 15:57:00 volumio kernel: VECM init Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: initialized by BL30 Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: calibration start: Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: nominal=0, value=5 Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: nominal=256, value=258 Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: nominal=512, value=515 Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: nominal=768, value=772 Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: nominal=1023, value=1019 Aug 29 15:57:00 volumio kernel: saradc c1108680.saradc: calibration end: coef=4080 Aug 29 15:57:00 volumio kernel: remote: Driver init Aug 29 15:57:00 volumio kernel: gpio_key- gpio_key_probe Aug 29 15:57:00 volumio kernel: gpio-key c8100000.gpio_keypad: gpio_key: find key_name=0 fail Aug 29 15:57:00 volumio kernel: gpio-key: probe of c8100000.gpio_keypad failed with error -22 Aug 29 15:57:00 volumio kernel: input: cec_input as /devices/virtual/input/input0 Aug 29 15:57:00 volumio kernel: cectx c810023c.aocec: aml_cec_probe(): can't find hdmirx Aug 29 15:57:00 volumio kernel: [58B blob data] Aug 29 15:57:00 volumio kernel: [42B blob data] Aug 29 15:57:00 volumio kernel: [58B blob data] Aug 29 15:57:00 volumio kernel: input: vt-input as /devices/virtual/input/input1 Aug 29 15:57:00 volumio kernel: [39B blob data] Aug 29 15:57:00 volumio kernel: enter aml_soc_platform_pcm2bt_probe Aug 29 15:57:00 volumio kernel: divider=16,frac=33920000,SDMval=4523 Aug 29 15:57:00 volumio kernel: enter aml_pcm_dai_probe Aug 29 15:57:00 volumio kernel: [aml-spdif-dai]enter aml_dai_spdif_init Aug 29 15:57:00 volumio kernel: aml_spdif_probe Aug 29 15:57:00 volumio kernel: enter spdif_dit_probe Aug 29 15:57:00 volumio kernel: odroid_hdmi_snd odroid_hdmi: dit-hifi <-> I2S mapping ok Aug 29 15:57:00 volumio kernel: GACT probability on Aug 29 15:57:00 volumio kernel: Mirror/redirect action on Aug 29 15:57:00 volumio kernel: u32 classifier Aug 29 15:57:00 volumio kernel: Performance counters on Aug 29 15:57:00 volumio kernel: input device check on Aug 29 15:57:00 volumio kernel: Actions configured Aug 29 15:57:00 volumio kernel: TCP: cubic registered Aug 29 15:57:00 volumio kernel: NET: Registered protocol family 17 Aug 29 15:57:00 volumio kernel: NET: Registered protocol family 15 Aug 29 15:57:00 volumio kernel: Bluetooth: RFCOMM TTY layer initialized Aug 29 15:57:00 volumio kernel: Bluetooth: RFCOMM socket layer initialized Aug 29 15:57:00 volumio kernel: Bluetooth: RFCOMM ver 1.11 Aug 29 15:57:00 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Aug 29 15:57:00 volumio kernel: Bluetooth: BNEP filters: protocol multicast Aug 29 15:57:00 volumio kernel: Bluetooth: BNEP socket layer initialized Aug 29 15:57:00 volumio kernel: Bluetooth: HIDP (Human Interface Emulation) ver 1.2 Aug 29 15:57:00 volumio kernel: Bluetooth: HIDP socket layer initialized Aug 29 15:57:00 volumio kernel: NET: Registered protocol family 35 Aug 29 15:57:00 volumio kernel: Key type dns_resolver registered Aug 29 15:57:00 volumio kernel: Registering SWP/SWPB emulation handler Aug 29 15:57:00 volumio kernel: registered taskstats version 1 Aug 29 15:57:00 volumio kernel: AppArmor: AppArmor sha1 policy hashing enabled Aug 29 15:57:00 volumio kernel: Mali DRM initialize, driver name: mali_drm, version 2.1 Aug 29 15:57:00 volumio kernel: [drm] Initialized mali_drm 2.1.1 20140306 on minor 0 Aug 29 15:57:00 volumio kernel: Mali DRM initialize, driver name: mali_drm, version 2.1 Aug 29 15:57:00 volumio kernel: [drm] Initialized mali_drm 2.1.1 20140306 on minor 1 Aug 29 15:57:00 volumio kernel: rtc_hctosys: unable to open rtc device (rtc0) Aug 29 15:57:00 volumio kernel: [23B blob data] Aug 29 15:57:00 volumio kernel: meson_pm_probe done Aug 29 15:57:00 volumio kernel: ALSA device list: Aug 29 15:57:00 volumio kernel: #0: ODROID-HDMI Aug 29 15:57:00 volumio kernel: sd: clk 83333333 SDR mode tuning start Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][0] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][1] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][2] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][3] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][4] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][5] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][6] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][7] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][8] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][9] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][10] = 10 Aug 29 15:57:00 volumio kernel: rx_tuning_result[0][11] = 10 Aug 29 15:57:00 volumio kernel: best_win_start =0, best_win_size =12 Aug 29 15:57:00 volumio kernel: sd_emmc_regs->gclock =0x100024c, sd_emmc_regs->gadjust =0x2000 Aug 29 15:57:00 volumio kernel: sd: gclock =0x100024c, gdelay=0x0 Aug 29 15:57:00 volumio kernel: gadjust=0x2000 Aug 29 15:57:00 volumio kernel: sd: new ultra high speed SDR104 SDXC card at address 59b4 Aug 29 15:57:00 volumio kernel: mmcblk0: sd:59b4 LX64G 58.9 GiB Aug 29 15:57:00 volumio kernel: mmcblk0: p1 p2 p3 Aug 29 15:57:00 volumio kernel: aml_emmc_hw_reset 1356 Aug 29 15:57:00 volumio kernel: [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0x2800,virqc:3fff Aug 29 15:57:00 volumio kernel: aml_sd_emmc_data_thread 2155 emmc: cmd:1 Aug 29 15:57:00 volumio kernel: emmc: error -110 whilst initialising MMC card Aug 29 15:57:00 volumio kernel: usb 1-1.4: new high-speed USB device number 3 using dwc_otg Aug 29 15:57:00 volumio kernel: random: nonblocking pool is initialized Aug 29 15:57:00 volumio kernel: Freeing unused kernel memory: 920K (ffffffc001b6b000 - ffffffc001c51000) Aug 29 15:57:00 volumio initramfs: Booting Volumio for ODROID-C2 Aug 29 15:57:00 volumio initramfs: This script mounts rootfs RO with an overlay RW layer. Aug 29 15:57:00 volumio unknown: OVERLAY VERSION V21 Aug 29 15:57:00 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 29 15:57:00 volumio kernel: fuse init (API version 7.23) Aug 29 15:57:00 volumio initramfs: IMGPART=/dev/mmcblk0p2 Aug 29 15:57:00 volumio initramfs: IMGFILE=/volumio_current.sqsh Aug 29 15:57:00 volumio initramfs: Boot delay (except first time) will be 5 seconds Aug 29 15:57:00 volumio initramfs: /dev/mmcblk0p2: Aug 29 15:57:00 volumio kernel: EXT4-fs (mmcblk0p2): recovery complete Aug 29 15:57:00 volumio kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Aug 29 15:57:00 volumio initramfs: Doing a 5 second delay here to give kernel load a headstart Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: viu_vd1 OFF Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: afbc_dec OFF Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: di_post OFF Aug 29 15:57:00 volumio kernel: switch_vpu_mem_pd: viu_vd2 OFF Aug 29 15:57:00 volumio initramfs: Checking for USB updates Aug 29 15:57:00 volumio initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Aug 29 15:57:00 volumio kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Aug 29 15:57:00 volumio kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Aug 29 15:57:00 volumio kernel: EXT4-fs (mmcblk0p3): recovery complete Aug 29 15:57:00 volumio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Aug 29 15:57:00 volumio initramfs: VOLUMIO_VERSION="3.212" Aug 29 15:57:00 volumio initramfs: Finish initramfs, continue booting Volumio Aug 29 15:57:00 volumio systemd[1]: System time before build time, advancing clock. Aug 29 15:57:00 volumio systemd[1]: Inserted module 'autofs4' Aug 29 15:57:00 volumio kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Aug 29 15:57:00 volumio systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Aug 29 15:57:00 volumio systemd[1]: Detected architecture arm64. Aug 29 15:57:00 volumio systemd[1]: Set hostname to . Aug 29 15:57:00 volumio systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling. Aug 29 15:57:00 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Aug 29 15:57:00 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 29 15:57:00 volumio systemd[1]: Binding to IPv6 address not available since kernel does not support IPv6. Aug 29 15:57:00 volumio systemd[1]: Binding to IPv6 address not available since kernel does not support IPv6. Aug 29 15:57:00 volumio systemd[1]: Listening on initctl Compatibility Named Pipe. Aug 29 15:57:00 volumio systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Aug 29 15:57:00 volumio systemd[1]: Reached target System Time Synchronized. Aug 29 15:57:00 volumio systemd[1]: Listening on udev Control Socket. Aug 29 15:57:00 volumio systemd[1]: Created slice User and Session Slice. Aug 29 15:57:00 volumio systemd[1]: Created slice system-getty.slice. Aug 29 15:57:00 volumio systemd[1]: Reached target Slices. Aug 29 15:57:00 volumio systemd[1]: Listening on Journal Socket (/dev/log). Aug 29 15:57:00 volumio systemd[1]: Listening on Journal Socket. Aug 29 15:57:00 volumio systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. Aug 29 15:57:00 volumio systemd[1]: Started dynamicswap service. Aug 29 15:57:00 volumio systemd[1]: Reached target Swap. Aug 29 15:57:00 volumio systemd[1]: Mounting Kernel Debug File System... Aug 29 15:57:00 volumio systemd[1]: Starting Restore / save the current clock... Aug 29 15:57:00 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Aug 29 15:57:00 volumio systemd[1]: Starting Remount Root and Kernel File Systems... Aug 29 15:57:00 volumio systemd[1]: Starting Create list of required static device nodes for the current kernel... Aug 29 15:57:00 volumio systemd[1]: Mounting RPC Pipe File System... Aug 29 15:57:00 volumio systemd[1]: Listening on RPCbind Server Activation Socket. Aug 29 15:57:00 volumio systemd[1]: Created slice system-serial\x2dgetty.slice. Aug 29 15:57:00 volumio systemd[1]: Mounting Huge Pages File System... Aug 29 15:57:00 volumio systemd[1]: Listening on fsck to fsckd communication Socket. Aug 29 15:57:00 volumio systemd[1]: Mounting POSIX Message Queue File System... Aug 29 15:57:00 volumio systemd[1]: Listening on Journal Audit Socket. Aug 29 15:57:00 volumio systemd[1]: Starting Journal Service... Aug 29 15:57:00 volumio systemd[1]: Created slice system-systemd\x2dfsck.slice. Aug 29 15:57:00 volumio systemd[1]: Started Forward Password Requests to Wall Directory Watch. Aug 29 15:57:00 volumio systemd[1]: Listening on udev Kernel Socket. Aug 29 15:57:00 volumio systemd[1]: Starting udev Coldplug all Devices... Aug 29 15:57:00 volumio systemd[1]: Starting Load Kernel Modules... Aug 29 15:57:00 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 29 15:57:00 volumio systemd-journald[203]: Journal started Aug 29 15:57:00 volumio systemd-journald[203]: Runtime journal (/run/log/journal/cb6cc78080c816e2b0842e1161f459f8) is 3.7M, max 30.0M, 26.2M free. Aug 29 15:57:00 volumio fake-hwclock[178]: Tue Aug 29 15:57:00 UTC 2023 Aug 29 15:57:00 volumio systemd[1]: Started Journal Service. Aug 29 15:57:00 volumio systemd[1]: Mounted Kernel Debug File System. Aug 29 15:57:00 volumio systemd-modules-load[205]: Inserted module 'snd_soc_pcm5102' Aug 29 15:57:00 volumio systemd-modules-load[205]: Inserted module 'snd_soc_odroid_dac' Aug 29 15:57:00 volumio kernel: pcm5102_platform_probe Aug 29 15:57:00 volumio kernel: odroid_dac_snd odroid_dac: pcm5102 <-> I2S mapping ok Aug 29 15:57:00 volumio systemd[1]: Started Restore / save the current clock. Aug 29 15:57:00 volumio systemd[1]: Started Remount Root and Kernel File Systems. Aug 29 15:57:00 volumio systemd[1]: Started Create list of required static device nodes for the current kernel. Aug 29 15:57:00 volumio systemd[1]: Mounted RPC Pipe File System. Aug 29 15:57:00 volumio systemd[1]: Mounted Huge Pages File System. Aug 29 15:57:00 volumio systemd[1]: Mounted POSIX Message Queue File System. Aug 29 15:57:00 volumio systemd[1]: Started Load Kernel Modules. Aug 29 15:57:00 volumio systemd[1]: Mounting FUSE Control File System... Aug 29 15:57:00 volumio systemd[1]: Starting Apply Kernel Variables... Aug 29 15:57:00 volumio systemd[1]: Mounting Kernel Configuration File System... Aug 29 15:57:00 volumio systemd[1]: Starting Load/Save Random Seed... Aug 29 15:57:00 volumio systemd-sysctl[212]: Couldn't write '1' to 'net/ipv6/conf/all/disable_ipv6', ignoring: No such file or directory Aug 29 15:57:00 volumio systemd-sysctl[212]: Couldn't write '1' to 'net/ipv6/conf/default/disable_ipv6', ignoring: No such file or directory Aug 29 15:57:00 volumio systemd-sysctl[212]: Couldn't write '1' to 'net/ipv6/conf/lo/disable_ipv6', ignoring: No such file or directory Aug 29 15:57:00 volumio systemd[1]: Starting Create System Users... Aug 29 15:57:00 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 29 15:57:00 volumio systemd[1]: Started udev Coldplug all Devices. Aug 29 15:57:00 volumio systemd[1]: Mounted FUSE Control File System. Aug 29 15:57:00 volumio systemd[1]: Started Apply Kernel Variables. Aug 29 15:57:00 volumio systemd[1]: Mounted Kernel Configuration File System. Aug 29 15:57:00 volumio systemd[1]: Started Load/Save Random Seed. Aug 29 15:57:00 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Aug 29 15:57:00 volumio systemd[1]: Started Create System Users. Aug 29 15:57:00 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Aug 29 15:57:00 volumio systemd[1]: Started Create Static Device Nodes in /dev. Aug 29 15:57:00 volumio systemd[1]: Reached target Local File Systems (Pre). Aug 29 15:57:00 volumio systemd[1]: Mounting /var/spool/cups... Aug 29 15:57:00 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Aug 29 15:57:00 volumio systemd[1]: Mounting /var/log... Aug 29 15:57:00 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Aug 29 15:57:00 volumio systemd[1]: Mounting /tmp... Aug 29 15:57:00 volumio systemd[1]: Starting udev Kernel Device Manager... Aug 29 15:57:00 volumio systemd[1]: Mounted /var/spool/cups. Aug 29 15:57:00 volumio systemd[1]: Mounted /var/log. Aug 29 15:57:00 volumio systemd[1]: Mounted /tmp. Aug 29 15:57:00 volumio systemd-udevd[232]: Network interface NamePolicy= disabled on kernel command line, ignoring. Aug 29 15:57:01 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Aug 29 15:57:01 volumio systemd[1]: Mounting /var/spool/cups/tmp... Aug 29 15:57:01 volumio systemd[1]: Started udev Kernel Device Manager. Aug 29 15:57:01 volumio systemd[1]: Mounted /var/spool/cups/tmp. Aug 29 15:57:01 volumio kernel: gpiomem-meson c8834000.gpiomem: Initialised: Registers at 0xc8834000 Aug 29 15:57:01 volumio systemd-udevd[239]: Using default interface naming scheme 'v240'. Aug 29 15:57:01 volumio systemd-udevd[239]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 29 15:57:01 volumio systemd-udevd[239]: link_config: could not get ethtool features for eth0 Aug 29 15:57:01 volumio systemd-udevd[239]: Could not set offload features of eth0: Device or resource busy Aug 29 15:57:01 volumio kernel: Driver for 1-wire Dallas network protocol. Aug 29 15:57:01 volumio systemd-journald[203]: Runtime journal (/run/log/journal/cb6cc78080c816e2b0842e1161f459f8) is 3.7M, max 30.0M, 26.2M free. Aug 29 15:57:01 volumio systemd[1]: Started Flush Journal to Persistent Storage. Aug 29 15:57:01 volumio systemd[1]: Found device /dev/ttyS0. Aug 29 15:57:01 volumio systemd-udevd[248]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 29 15:57:01 volumio kernel: ionvideo open Aug 29 15:57:01 volumio kernel: cfg80211: Calling CRDA to update world regulatory domain Aug 29 15:57:01 volumio kernel: ionvideo_stop_generating!!!! Aug 29 15:57:01 volumio kernel: ionvideo release Aug 29 15:57:01 volumio kernel: usb 1-1.4: ath9k_htc: Firmware htc_9271.fw requested Aug 29 15:57:01 volumio kernel: usbcore: registered new interface driver ath9k_htc Aug 29 15:57:01 volumio systemd-udevd[254]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Aug 29 15:57:01 volumio kernel: usb 1-1.4: firmware: direct-loading firmware htc_9271.fw Aug 29 15:57:01 volumio kernel: cfg80211: World regulatory domain updated: Aug 29 15:57:01 volumio systemd-udevd[240]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Aug 29 15:57:01 volumio kernel: cfg80211: DFS Master region: unset Aug 29 15:57:01 volumio kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Aug 29 15:57:01 volumio kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Aug 29 15:57:01 volumio systemd[1]: Found device /dev/mmcblk0p1. Aug 29 15:57:01 volumio kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A) Aug 29 15:57:01 volumio kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Aug 29 15:57:01 volumio kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Aug 29 15:57:01 volumio kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Aug 29 15:57:01 volumio kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Aug 29 15:57:01 volumio kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Aug 29 15:57:01 volumio kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Aug 29 15:57:01 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Aug 29 15:57:01 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Aug 29 15:57:01 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Aug 29 15:57:01 volumio systemd[1]: Starting File System Check on /dev/mmcblk0p1... Aug 29 15:57:01 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Aug 29 15:57:01 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 29 15:57:01 volumio systemd-fsck[291]: fsck.fat 4.1 (2017-01-24) Aug 29 15:57:01 volumio systemd-fsck[291]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Aug 29 15:57:01 volumio systemd-fsck[291]: Automatically removing dirty bit. Aug 29 15:57:01 volumio systemd-fsck[291]: Performing changes. Aug 29 15:57:01 volumio systemd-fsck[291]: /dev/mmcblk0p1: 13 files, 9309/30651 clusters Aug 29 15:57:01 volumio systemd[1]: Starting Show Plymouth Boot Screen... Aug 29 15:57:01 volumio systemd[1]: Started File System Check on /dev/mmcblk0p1. Aug 29 15:57:02 volumio systemd[1]: Started File System Check Daemon to report status. Aug 29 15:57:02 volumio systemd[1]: Mounting /boot... Aug 29 15:57:02 volumio systemd[1]: Received SIGRTMIN+20 from PID 298 (plymouthd). Aug 29 15:57:02 volumio kernel: usb 1-1.4: ath9k_htc: Transferred FW: htc_9271.fw, size: 50980 Aug 29 15:57:02 volumio systemd[1]: Mounted /boot. Aug 29 15:57:02 volumio systemd[1]: Started Show Plymouth Boot Screen. Aug 29 15:57:02 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 29 15:57:02 volumio systemd[1]: Reached target Paths. Aug 29 15:57:02 volumio systemd[1]: Reached target Local Encrypted Volumes. Aug 29 15:57:02 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Aug 29 15:57:02 volumio systemd[1]: Reached target Local File Systems. Aug 29 15:57:02 volumio systemd[1]: Started ifup for eth0. Aug 29 15:57:02 volumio systemd[1]: Starting Raise network interfaces... Aug 29 15:57:02 volumio systemd[1]: Starting Create Volatile Files and Directories... Aug 29 15:57:02 volumio systemd[1]: Starting Preprocess NFS configuration... Aug 29 15:57:02 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Aug 29 15:57:02 volumio systemd[1]: Starting Commit a transient machine-id on disk... Aug 29 15:57:02 volumio systemd[1]: nfs-config.service: Succeeded. Aug 29 15:57:02 volumio systemd[1]: Started Preprocess NFS configuration. Aug 29 15:57:02 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Aug 29 15:57:02 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Aug 29 15:57:02 volumio systemd[1]: Reached target NFS client services. Aug 29 15:57:02 volumio kernel: ath9k_htc 1-1.4:1.0: ath9k_htc: HTC initialized with 33 credits Aug 29 15:57:02 volumio systemd[1]: Received SIGRTMIN+20 from PID 298 (plymouthd). Aug 29 15:57:02 volumio systemd-machine-id-setup[315]: /etc/machine-id is not on a temporary file system. Aug 29 15:57:02 volumio sh[302]: command failed: No such device (-19) Aug 29 15:57:02 volumio ifup[303]: command failed: No such device (-19) Aug 29 15:57:02 volumio systemd[1]: plymouth-read-write.service: Succeeded. Aug 29 15:57:02 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Aug 29 15:57:02 volumio systemd[1]: Started Create Volatile Files and Directories. Aug 29 15:57:02 volumio systemd[1]: systemd-machine-id-commit.service: Main process exited, code=exited, status=1/FAILURE Aug 29 15:57:02 volumio systemd[1]: systemd-machine-id-commit.service: Failed with result 'exit-code'. Aug 29 15:57:02 volumio systemd[1]: Failed to start Commit a transient machine-id on disk. Aug 29 15:57:02 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Aug 29 15:57:02 volumio kernel: ath9k_htc 1-1.4:1.0: ath9k_htc: FW Version: 1.3 Aug 29 15:57:02 volumio kernel: ath: EEPROM regdomain: 0x809c Aug 29 15:57:02 volumio kernel: ath: EEPROM indicates we should expect a country code Aug 29 15:57:02 volumio kernel: ath: doing EEPROM country->regdmn map search Aug 29 15:57:02 volumio kernel: ath: country maps to regdmn code: 0x52 Aug 29 15:57:02 volumio kernel: ath: Country alpha2 being used: CN Aug 29 15:57:02 volumio kernel: ath: Regpair used: 0x52 Aug 29 15:57:02 volumio kernel: ieee80211 phy0: Atheros AR9271 Rev:1 Aug 29 15:57:02 volumio kernel: cfg80211: Calling CRDA for country: CN Aug 29 15:57:02 volumio systemd-udevd[240]: Using default interface naming scheme 'v240'. Aug 29 15:57:02 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Aug 29 15:57:02 volumio systemd-udevd[240]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 29 15:57:02 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Aug 29 15:57:02 volumio systemd[1]: Starting RPC bind portmap service... Aug 29 15:57:02 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Aug 29 15:57:02 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... Aug 29 15:57:02 volumio systemd[1]: Started Load/Save RF Kill Switch Status. Aug 29 15:57:02 volumio rpcbind[385]: cannot create socket for udp6 Aug 29 15:57:02 volumio sh[302]: eth0: waiting for carrier Aug 29 15:57:02 volumio dhcpcd[354]: eth0: waiting for carrier Aug 29 15:57:02 volumio dhcpcd[354]: eth0: carrier acquired Aug 29 15:57:02 volumio sh[302]: eth0: carrier acquired Aug 29 15:57:02 volumio kernel: cfg80211: Regulatory domain changed to country: CN Aug 29 15:57:02 volumio kernel: cfg80211: DFS Master region: FCC Aug 29 15:57:02 volumio kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Aug 29 15:57:02 volumio kernel: cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Aug 29 15:57:02 volumio kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (N/A) Aug 29 15:57:02 volumio kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s) Aug 29 15:57:02 volumio kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A) Aug 29 15:57:02 volumio kernel: cfg80211: (57240000 KHz - 59400000 KHz @ 2160000 KHz), (N/A, 2800 mBm), (N/A) Aug 29 15:57:02 volumio kernel: cfg80211: (59400000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4400 mBm), (N/A) Aug 29 15:57:02 volumio kernel: cfg80211: (63720000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 2800 mBm), (N/A) Aug 29 15:57:02 volumio kernel: eth0: device MAC address 00:1e:06:34:7d:fb Aug 29 15:57:02 volumio rpcbind[385]: cannot create socket for tcp6 Aug 29 15:57:02 volumio sh[302]: DUID 00:01:00:01:29:87:16:ef Aug 29 15:57:02 volumio sh[302]: eth0: IAID 65:74:68:30 Aug 29 15:57:02 volumio sh[302]: eth0: ipv6_start: Operation not supported Aug 29 15:57:02 volumio dhcpcd[354]: DUID 00:01:00:01:29:87:16:ef Aug 29 15:57:02 volumio dhcpcd[354]: eth0: IAID 65:74:68:30 Aug 29 15:57:02 volumio dhcpcd[354]: eth0: ipv6_start: Operation not supported Aug 29 15:57:02 volumio systemd[1]: Started RPC bind portmap service. Aug 29 15:57:02 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Aug 29 15:57:02 volumio systemd[1]: Reached target System Initialization. Aug 29 15:57:02 volumio systemd[1]: Listening on mpd.socket. Aug 29 15:57:02 volumio systemd[1]: Listening on lircd.socket. Aug 29 15:57:02 volumio systemd[1]: apt-daily.timer: Not using persistent file timestamp Tue 2024-10-15 19:55:02 UTC as it is in the future. Aug 29 15:57:02 volumio systemd[1]: Started Daily apt download activities. Aug 29 15:57:02 volumio systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Wed 2024-10-16 06:23:02 UTC as it is in the future. Aug 29 15:57:02 volumio systemd[1]: Started Daily apt upgrade and clean activities. Aug 29 15:57:02 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Aug 29 15:57:02 volumio systemd[1]: Reached target Timers. Aug 29 15:57:02 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Aug 29 15:57:02 volumio systemd[1]: Listening on triggerhappy.socket. Aug 29 15:57:02 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Aug 29 15:57:02 volumio systemd[1]: Reached target Sockets. Aug 29 15:57:02 volumio systemd[1]: Reached target Basic System. Aug 29 15:57:03 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Aug 29 15:57:03 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Aug 29 15:57:03 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 29 15:57:03 volumio thd[427]: Unable to parse trigger line: Aug 29 15:57:03 volumio thd[427]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Aug 29 15:57:03 volumio thd[427]: Unable to parse trigger line: Aug 29 15:57:03 volumio thd[427]: Found socket passed from systemd Aug 29 15:57:03 volumio systemd[1]: Starting lircd(8) initialization helper tool... Aug 29 15:57:03 volumio systemd[1]: Started Volumio Iptables Module. Aug 29 15:57:03 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Aug 29 15:57:03 volumio systemd[1]: Started Manage Sound Card State (restore and store). Aug 29 15:57:03 volumio systemd[1]: Starting Save/Restore Sound Card State... Aug 29 15:57:03 volumio alsactl[435]: alsactl 1.1.8 daemon started Aug 29 15:57:03 volumio systemd[1]: Started Detect Odroid DAC. Aug 29 15:57:03 volumio systemd[1]: Starting Wireless Services... Aug 29 15:57:03 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Aug 29 15:57:03 volumio systemd[1]: Started volumio-remote-updater.service. Aug 29 15:57:03 volumio systemd[1]: Started D-Bus System Message Bus. Aug 29 15:57:03 volumio systemd[1]: Starting WPA supplicant... Aug 29 15:57:03 volumio systemd[1]: Starting Login Service... Aug 29 15:57:03 volumio systemd[1]: Reached target RPC Port Mapper. Aug 29 15:57:03 volumio systemd[1]: Reached target Remote File Systems (Pre). Aug 29 15:57:03 volumio systemd[1]: Reached target Remote File Systems. Aug 29 15:57:03 volumio avahi-daemon[429]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Aug 29 15:57:03 volumio avahi-daemon[429]: Successfully dropped root privileges. Aug 29 15:57:03 volumio avahi-daemon[429]: avahi-daemon 0.7 starting up. Aug 29 15:57:03 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Aug 29 15:57:03 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Aug 29 15:57:03 volumio systemd[1]: Starting DHCP Client Daemon... Aug 29 15:57:03 volumio systemd[1]: Started triggerhappy global hotkey daemon. Aug 29 15:57:03 volumio kernel: Netfilter messages via NETLINK v0.30. Aug 29 15:57:03 volumio kernel: aml_i2c version: 20140813 Aug 29 15:57:03 volumio systemd[1]: Started Save/Restore Sound Card State. Aug 29 15:57:03 volumio kernel: aml-i2c c1108500.i2c: add adapter aml_i2c_adap1(ffffffc0563610e0) Aug 29 15:57:03 volumio avahi-daemon[429]: Successfully called chroot(). Aug 29 15:57:03 volumio avahi-daemon[429]: Successfully dropped remaining capabilities. Aug 29 15:57:03 volumio avahi-daemon[429]: No service file found in /etc/avahi/services. Aug 29 15:57:03 volumio systemd-logind[448]: New seat seat0. Aug 29 15:57:03 volumio systemd[1]: Found device AR9271 802.11n. Aug 29 15:57:03 volumio avahi-daemon[429]: socket() failed: Address family not supported by protocol Aug 29 15:57:03 volumio avahi-daemon[429]: Failed to create IPv6 socket, proceeding in IPv4 only mode Aug 29 15:57:03 volumio avahi-daemon[429]: socket() failed: Address family not supported by protocol Aug 29 15:57:03 volumio avahi-daemon[429]: Network interface enumeration completed. Aug 29 15:57:03 volumio avahi-daemon[429]: Server startup complete. Host name is volumio.local. Local service cookie is 1576611288. Aug 29 15:57:03 volumio kernel: nf_tables: (c) 2007-2009 Patrick McHardy Aug 29 15:57:03 volumio kernel: sx865x 2-0049: sx865x_probe() Aug 29 15:57:03 volumio kernel: sx865x 2-0049: swap_xy (1) Aug 29 15:57:03 volumio kernel: sx865x 2-0049: invert_x (0) Aug 29 15:57:03 volumio kernel: sx865x 2-0049: invert_y (1) Aug 29 15:57:03 volumio kernel: sx865x 2-0049: gpio pendown (218) Aug 29 15:57:03 volumio kernel: sx865x 2-0049: gpio reset (224) Aug 29 15:57:03 volumio kernel: sx865x 2-0049: gpio irq (96) Aug 29 15:57:03 volumio kernel: i2c i2c-2: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-2: token 1, master_no(2) 300K addr 0x49 Aug 29 15:57:03 volumio kernel: i2c i2c-2: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-2: token 1, master_no(2) 300K addr 0x49 Aug 29 15:57:03 volumio kernel: i2c i2c-2: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-2: token 1, master_no(2) 300K addr 0x49 Aug 29 15:57:03 volumio kernel: i2c i2c-2: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-2: token 1, master_no(2) 300K addr 0x49 Aug 29 15:57:03 volumio kernel: i2c i2c-2: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-2: token 1, master_no(2) 300K addr 0x49 Aug 29 15:57:03 volumio kernel: i2c i2c-2: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-2: token 1, master_no(2) 300K addr 0x49 Aug 29 15:57:03 volumio kernel: sx865x: probe of 2-0049 failed with error -5 Aug 29 15:57:03 volumio kernel: aml-i2c c11087c0.i2c: add adapter aml_i2c_adap2(ffffffc0563618e0) Aug 29 15:57:03 volumio kernel: nf_tables_compat: (c) 2012 Pablo Neira Ayuso Aug 29 15:57:03 volumio kernel: 1-004c supply AVDD not found, using dummy regulator Aug 29 15:57:03 volumio kernel: 1-004c supply DVDD not found, using dummy regulator Aug 29 15:57:03 volumio kernel: 1-004c supply CPVDD not found, using dummy regulator Aug 29 15:57:03 volumio kernel: i2c i2c-1: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-1: token 1, master_no(1) 300K addr 0x4c Aug 29 15:57:03 volumio kernel: i2c i2c-1: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-1: token 1, master_no(1) 300K addr 0x4c Aug 29 15:57:03 volumio kernel: i2c i2c-1: [aml_i2c_xfer] error ret = -5 (-EIO) Aug 29 15:57:03 volumio kernel: i2c i2c-1: token 1, master_no(1) 300K addr 0x4c Aug 29 15:57:03 volumio kernel: pcm512x 1-004c: Failed to reset device: -11 Aug 29 15:57:03 volumio kernel: pcm512x: probe of 1-004c failed with error -11 Aug 29 15:57:03 volumio kernel: i2c i2c-1: new_device: Instantiated device pcm5242 at 0x4c Aug 29 15:57:03 volumio kernel: odroid_dac2 odroid_dac2: ASoC: CODEC pcm512x.1-004c not registered Aug 29 15:57:03 volumio kernel: odroid_dac2 odroid_dac2: snd_soc_register_card failed (-517) Aug 29 15:57:03 volumio kernel: platform odroid_dac2: Driver odroid_dac2 requests probe deferral Aug 29 15:57:03 volumio kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Aug 29 15:57:03 volumio systemd[1]: Started ifup for wlan0. Aug 29 15:57:03 volumio systemd[1]: Reached target Sound Card. Aug 29 15:57:03 volumio sh[493]: ifup: waiting for lock on /run/network/ifstate.wlan0 Aug 29 15:57:03 volumio systemd-logind[448]: Watching system buttons on /dev/input/event0 (cec_input) Aug 29 15:57:03 volumio systemd-logind[448]: Watching system buttons on /dev/input/event1 (vt-input) Aug 29 15:57:03 volumio sh[302]: eth0: needs a clientid to configure Aug 29 15:57:03 volumio dhcpcd[354]: eth0: needs a clientid to configure Aug 29 15:57:03 volumio dhcpcd[451]: DUID 00:01:00:01:29:87:16:ef Aug 29 15:57:03 volumio dhcpcd[451]: eth0: IAID 06:34:7d:fb Aug 29 15:57:03 volumio dhcpcd[451]: eth0: adding address fe80::21e:6ff:fe34:7dfb Aug 29 15:57:03 volumio dhcpcd[451]: ipv6_addaddr1: Operation not supported Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: waiting for carrier Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: carrier acquired Aug 29 15:57:03 volumio dhcpcd[451]: DUID 00:01:00:01:29:87:16:ef Aug 29 15:57:03 volumio dhcpcd[451]: eth0: IAID 06:34:7d:fb Aug 29 15:57:03 volumio dhcpcd[451]: eth0: adding address fe80::21e:6ff:fe34:7dfb Aug 29 15:57:03 volumio dhcpcd[451]: ipv6_addaddr1: Operation not supported Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: waiting for carrier Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: carrier acquired Aug 29 15:57:03 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: IAID 11:63:13:b6 Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: adding address fe80::fad1:11ff:fe63:13b6 Aug 29 15:57:03 volumio dhcpcd[451]: ipv6_addaddr1: Operation not supported Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: probing address 10.0.0.6/24 Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: IAID 11:63:13:b6 Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: adding address fe80::fad1:11ff:fe63:13b6 Aug 29 15:57:03 volumio dhcpcd[451]: ipv6_addaddr1: Operation not supported Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: probing address 10.0.0.6/24 Aug 29 15:57:03 volumio kernel: i2c i2c-1: delete_device: Deleting device pcm5242 at 0x4c Aug 29 15:57:03 volumio systemd[1]: Started Login Service. Aug 29 15:57:03 volumio dhcpcd[451]: eth0: soliciting a DHCP lease Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: carrier lost Aug 29 15:57:03 volumio dhcpcd[451]: eth0: soliciting a DHCP lease Aug 29 15:57:03 volumio dhcpcd[451]: wlan0: carrier lost Aug 29 15:57:03 volumio sh[493]: ifup: interface wlan0 already configured Aug 29 15:57:03 volumio systemd[1]: Started WPA supplicant. Aug 29 15:57:03 volumio sh[493]: wlan0=wlan0 Aug 29 15:57:03 volumio wpa_supplicant[445]: Successfully initialized wpa_supplicant Aug 29 15:57:04 volumio kernel: pcm5102_platform_probe Aug 29 15:57:04 volumio kernel: odroid_dac_snd odroid_dac: pcm5102 <-> I2S mapping ok Aug 29 15:57:04 volumio systemd[1]: odroiddac.service: Succeeded. Aug 29 15:57:04 volumio systemd[1]: Started Raise network interfaces. Aug 29 15:57:04 volumio systemd[1]: Reached target Network. Aug 29 15:57:04 volumio systemd[1]: Reached target Network is Online. Aug 29 15:57:04 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Aug 29 15:57:04 volumio volumio-remote-updater[439]: Error: No active session Aug 29 15:57:04 volumio volumio-remote-updater[439]: [2023-08-29 15:57:04] [info] asio async_connect error: system:111 (Connection refused) Aug 29 15:57:04 volumio volumio-remote-updater[439]: [2023-08-29 15:57:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 29 15:57:04 volumio volumio-remote-updater[439]: [2023-08-29 15:57:04] [error] handle_connect error: Underlying Transport Error Aug 29 15:57:04 volumio dhcpcd[451]: eth0: soliciting an IPv6 router Aug 29 15:57:04 volumio loadcpufreq[450]: Loading cpufreq kernel modules...done (none). Aug 29 15:57:04 volumio dhcpcd[451]: eth0: soliciting an IPv6 router Aug 29 15:57:04 volumio dhcpcd[451]: ipv6nd_startrs1: Address family not supported by protocol Aug 29 15:57:04 volumio dhcpcd[451]: ipv6nd_startrs1: Address family not supported by protocol Aug 29 15:57:04 volumio systemd[1]: Starting /etc/rc.local Compatibility... Aug 29 15:57:04 volumio systemd[1]: Starting Music Player Daemon... Aug 29 15:57:04 volumio systemd[1]: Starting Network Time Service... Aug 29 15:57:04 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Aug 29 15:57:04 volumio systemd[1]: Starting Permit User Sessions... Aug 29 15:57:04 volumio systemd[1]: Starting Samba NMB Daemon... Aug 29 15:57:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 29 15:57:04 volumio volumio[432]: Could not open config: /tmp/upmpdcli.conf Aug 29 15:57:04 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Aug 29 15:57:04 volumio kernel: vout_serve: vmode set to 1080p60hz Aug 29 15:57:04 volumio kernel: vout_serve: don't set the same mode as current. Aug 29 15:57:04 volumio dhcpcd[451]: eth0: carrier lost Aug 29 15:57:04 volumio dhcpcd[451]: eth0: carrier lost Aug 29 15:57:04 volumio sh[302]: eth0: carrier lost Aug 29 15:57:04 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 29 15:57:04 volumio dhcpcd[354]: eth0: carrier lost Aug 29 15:57:04 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 29 15:57:04 volumio systemd[1]: Started Permit User Sessions. Aug 29 15:57:04 volumio kernel: vout_serve: vmode set to 1080p60hz Aug 29 15:57:04 volumio kernel: vout_serve: don't set the same mode as current. Aug 29 15:57:04 volumio ntpd[609]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 29 15:57:04 volumio ntpd[609]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 29 15:57:04 volumio systemd[1]: iptables.service: Succeeded. Aug 29 15:57:04 volumio systemd[1]: Started /etc/rc.local Compatibility. Aug 29 15:57:05 volumio lircd-setup[433]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Aug 29 15:57:05 volumio lircd-setup[433]: parser = configparser.SafeConfigParser() Aug 29 15:57:05 volumio systemd[1]: Started Network Time Service. Aug 29 15:57:05 volumio ntpd[661]: proto: precision = 1.000 usec (-20) Aug 29 15:57:05 volumio ntpd[661]: restrict: ignoring line 40, mask '::' unusable. Aug 29 15:57:05 volumio ntpd[661]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 29 15:57:05 volumio ntpd[661]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 29 15:57:05 volumio ntpd[661]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 428 days ago Aug 29 15:57:05 volumio ntpd[661]: Listen and drop on 0 v4wildcard 0.0.0.0:123 Aug 29 15:57:05 volumio systemd[1]: lircd-setup.service: Succeeded. Aug 29 15:57:05 volumio ntpd[661]: Listen normally on 1 lo 127.0.0.1:123 Aug 29 15:57:05 volumio ntpd[661]: Listening on routing socket on fd #18 for interface updates Aug 29 15:57:05 volumio ntpd[661]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 29 15:57:05 volumio ntpd[661]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 29 15:57:05 volumio systemd[1]: Started lircd(8) initialization helper tool. Aug 29 15:57:05 volumio systemd[1]: Starting Flexible IR remote input/output application support... Aug 29 15:57:05 volumio systemd[1]: Starting Hold until boot process finishes up... Aug 29 15:57:05 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Aug 29 15:57:05 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Aug 29 15:57:05 volumio lircd-0.10.1[671]: Info: lircd: Opening log, level: Info Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Version: lircd 0.10.1 Aug 29 15:57:05 volumio systemd[1]: Received SIGRTMIN+21 from PID 298 (plymouthd). Aug 29 15:57:05 volumio ifplugd(eth0)[689]: ifplugd 0.28 initializing. Aug 29 15:57:05 volumio ifplugd(eth0)[689]: Using interface eth0/00:1E:06:34:7D:FB with driver (version: March_2013) Aug 29 15:57:05 volumio systemd[1]: plymouth-start.service: Succeeded. Aug 29 15:57:05 volumio ifplugd(eth0)[689]: Using detection mode: SIOCETHTOOL Aug 29 15:57:05 volumio ifplugd(eth0)[689]: Initialization complete, link beat not detected. Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: System info: Linux volumio 3.16.85 #5 SMP PREEMPT Wed Jan 27 11:35:54 CET 2021 aarch64 GNU/Linux Aug 29 15:57:05 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Aug 29 15:57:05 volumio systemd[1]: Started Hold until boot process finishes up. Aug 29 15:57:05 volumio systemd[1]: plymouth-quit.service: Succeeded. Aug 29 15:57:05 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Aug 29 15:57:05 volumio systemd[1]: Received SIGRTMIN+21 from PID 298 (n/a). Aug 29 15:57:05 volumio ifplugd[592]: Network Interface Plugging Daemon...start eth0...done. Aug 29 15:57:05 volumio lircd[671]: lircd-0.10.1[671]: Info: lircd: Opening log, level: Info Aug 29 15:57:05 volumio lircd[671]: lircd-0.10.1[671]: Notice: Using systemd fd Aug 29 15:57:05 volumio lircd[671]: lircd-0.10.1[671]: Warning: Running as root Aug 29 15:57:05 volumio lircd[671]: lircd-0.10.1[671]: Info: Using remote: lircd.conf. Aug 29 15:57:05 volumio lircd[671]: lircd-0.10.1[671]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Aug 29 15:57:05 volumio lircd-0.10.1[671]: Info: Initial device: auto Aug 29 15:57:05 volumio lircd-0.10.1[671]: Info: Initial device: auto Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: driver: devinput Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: output: /var/run/lirc/lircd Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: nodaemon: 1 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: logfile: syslog Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: immediate-init: 0 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: permission: 666 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: driver-options: Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: listen: 0 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: connect: (null) Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: userelease: 0 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: effective_user: (null) Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: release_suffix: _EVUP Aug 29 15:57:05 volumio systemd[1]: Started Getty on tty1. Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: allow_simulate: 0 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: repeat_max: 600 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: configfile: /etc/lirc/lircd.conf Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Options: dynamic_codes: (null) Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Current driver: devinput Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Driver API version: 4 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Driver version: 0.10.0 Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/devinput.html Aug 29 15:57:05 volumio lircd-0.10.1[671]: Info: lircd: Opening log, level: Info Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: Using systemd fd Aug 29 15:57:05 volumio lircd-0.10.1[671]: Warning: Running as root Aug 29 15:57:05 volumio lircd-0.10.1[671]: Info: Using remote: lircd.conf. Aug 29 15:57:05 volumio lircd-0.10.1[671]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Aug 29 15:57:05 volumio systemd[1]: Started Serial Getty on ttyS0. Aug 29 15:57:05 volumio systemd[1]: Reached target Login Prompts. Aug 29 15:57:05 volumio systemd[1]: Started Flexible IR remote input/output application support. Aug 29 15:57:05 volumio systemd[1]: Started LSB: Brings up/down network automatically. Aug 29 15:57:05 volumio cpufrequtils[679]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Aug 29 15:57:05 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Aug 29 15:57:05 volumio haveged[380]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Aug 29 15:57:05 volumio haveged[380]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Aug 29 15:57:05 volumio haveged[380]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99869 Aug 29 15:57:05 volumio haveged[380]: haveged: fills: 0, generated: 0 Aug 29 15:57:05 volumio nmbd[628]: [2023/08/29 15:57:05.898535, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Aug 29 15:57:05 volumio nmbd[628]: started asyncdns process 712 Aug 29 15:57:05 volumio nmbd[628]: [2023/08/29 15:57:05.902082, 0] ../lib/util/become_daemon.c:149(daemon_status) Aug 29 15:57:05 volumio nmbd[628]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Aug 29 15:57:05 volumio nmbd[628]: [2023/08/29 15:57:05.902714, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Aug 29 15:57:05 volumio nmbd[628]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Aug 29 15:57:06 volumio ntpd[661]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Aug 29 15:57:06 volumio wireless.js[438]: WIRELESS DAEMON: start Aug 29 15:57:06 volumio wireless.js[438]: WIRELESS: Loaded configuration Aug 29 15:57:06 volumio wireless.js[438]: Cleaning previous... Aug 29 15:57:06 volumio sudo[717]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 29 15:57:06 volumio sudo[717]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:06 volumio sudo[717]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:06 volumio sudo[721]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 29 15:57:06 volumio sudo[721]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:07 volumio sudo[721]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:07 volumio ntpd[661]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 29 15:57:07 volumio wireless.js[438]: Stopped aP Aug 29 15:57:07 volumio wireless.js[438]: Start wireless flow Aug 29 15:57:07 volumio wireless.js[438]: Stopped hotspot (if there).. Aug 29 15:57:07 volumio sudo[730]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 29 15:57:07 volumio sudo[730]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:07 volumio sudo[730]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:07 volumio sudo[734]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 29 15:57:07 volumio sudo[734]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:07 volumio sudo[734]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:07 volumio wireless.js[438]: DHCP IP Aug 29 15:57:07 volumio wireless.js[438]: Start ap Aug 29 15:57:07 volumio wpa_supplicant[738]: Successfully initialized wpa_supplicant Aug 29 15:57:07 volumio sudo[739]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Aug 29 15:57:07 volumio sudo[739]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:07 volumio dhcpcd[742]: sending commands to master dhcpcd process Aug 29 15:57:07 volumio dhcpcd[451]: control command: /sbin/dhcpcd Aug 29 15:57:07 volumio sudo[739]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:07 volumio dhcpcd[451]: control command: /sbin/dhcpcd Aug 29 15:57:07 volumio systemd[1]: systemd-rfkill.service: Succeeded. Aug 29 15:57:07 volumio mpd[701]: Aug 29 15:57 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 29 15:57:08 volumio mpd[701]: Aug 29 15:57 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Aug 29 15:57:08 volumio mpd[701]: Aug 29 15:57 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Aug 29 15:57:08 volumio systemd[1]: Started Music Player Daemon. Aug 29 15:57:08 volumio ntpd[661]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 29 15:57:08 volumio wireless.js[438]: trying... Aug 29 15:57:08 volumio sudo[750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:08 volumio sudo[750]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:08 volumio sudo[750]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:09 volumio ntpd[661]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Aug 29 15:57:09 volumio wireless.js[438]: trying... Aug 29 15:57:09 volumio wpa_supplicant[743]: wlan0: SME: Trying to authenticate with 20:4e:7f:c3:89:5f (SSID='pre26set45' freq=2437 MHz) Aug 29 15:57:09 volumio kernel: wlan0: authenticate with 20:4e:7f:c3:89:5f Aug 29 15:57:09 volumio kernel: wlan0: send auth to 20:4e:7f:c3:89:5f (try 1/3) Aug 29 15:57:09 volumio volumio-remote-updater[439]: [2023-08-29 15:57:09] [info] asio async_connect error: system:111 (Connection refused) Aug 29 15:57:09 volumio volumio-remote-updater[439]: [2023-08-29 15:57:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 29 15:57:09 volumio volumio-remote-updater[439]: [2023-08-29 15:57:09] [error] handle_connect error: Underlying Transport Error Aug 29 15:57:09 volumio wpa_supplicant[743]: wlan0: Trying to associate with 20:4e:7f:c3:89:5f (SSID='pre26set45' freq=2437 MHz) Aug 29 15:57:09 volumio sudo[755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:09 volumio kernel: wlan0: authenticated Aug 29 15:57:09 volumio kernel: wlan0: associate with 20:4e:7f:c3:89:5f (try 1/3) Aug 29 15:57:09 volumio sudo[755]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:09 volumio sudo[755]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:09 volumio kernel: wlan0: RX AssocResp from 20:4e:7f:c3:89:5f (capab=0x411 status=0 aid=3) Aug 29 15:57:09 volumio wpa_supplicant[743]: wlan0: Associated with 20:4e:7f:c3:89:5f Aug 29 15:57:09 volumio wpa_supplicant[743]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 29 15:57:09 volumio kernel: wlan0: associated Aug 29 15:57:09 volumio wpa_supplicant[743]: wlan0: WPA: Key negotiation completed with 20:4e:7f:c3:89:5f [PTK=CCMP GTK=CCMP] Aug 29 15:57:09 volumio dhcpcd[451]: wlan0: carrier acquired Aug 29 15:57:09 volumio wpa_supplicant[743]: wlan0: CTRL-EVENT-CONNECTED - Connection to 20:4e:7f:c3:89:5f completed [id=0 id_str=] Aug 29 15:57:09 volumio dhcpcd[451]: wlan0: carrier acquired Aug 29 15:57:09 volumio dhcpcd[451]: wlan0: IAID 11:63:13:b6 Aug 29 15:57:09 volumio dhcpcd[451]: wlan0: probing address 10.0.0.6/24 Aug 29 15:57:09 volumio dhcpcd[451]: wlan0: IAID 11:63:13:b6 Aug 29 15:57:09 volumio dhcpcd[451]: wlan0: probing address 10.0.0.6/24 Aug 29 15:57:10 volumio dhcpcd[451]: wlan0: soliciting an IPv6 router Aug 29 15:57:10 volumio dhcpcd[451]: wlan0: soliciting an IPv6 router Aug 29 15:57:10 volumio dhcpcd[451]: ipv6nd_startrs1: Address family not supported by protocol Aug 29 15:57:10 volumio dhcpcd[451]: ipv6nd_startrs1: Address family not supported by protocol Aug 29 15:57:10 volumio wireless.js[438]: trying... Aug 29 15:57:10 volumio sudo[780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:10 volumio sudo[780]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:10 volumio sudo[780]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:11 volumio wireless.js[438]: trying... Aug 29 15:57:11 volumio sudo[785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:11 volumio sudo[785]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:11 volumio sudo[785]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:12 volumio wireless.js[438]: trying... Aug 29 15:57:12 volumio sudo[790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:12 volumio sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:12 volumio sudo[790]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:13 volumio wireless.js[438]: trying... Aug 29 15:57:13 volumio sudo[795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:13 volumio sudo[795]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:13 volumio sudo[795]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:14 volumio wireless.js[438]: trying... Aug 29 15:57:14 volumio sudo[800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:14 volumio sudo[800]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:14 volumio sudo[800]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: using static address 10.0.0.6/24 Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: router 192.168.1.64 requires a host route Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: adding route to 10.0.0.0/24 Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: adding host route to 192.168.1.64 Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: adding default route via 192.168.1.64 Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: using static address 10.0.0.6/24 Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: router 192.168.1.64 requires a host route Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: adding route to 10.0.0.0/24 Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: adding host route to 192.168.1.64 Aug 29 15:57:14 volumio dhcpcd[451]: wlan0: adding default route via 192.168.1.64 Aug 29 15:57:14 volumio avahi-daemon[429]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.6. Aug 29 15:57:14 volumio avahi-daemon[429]: New relevant interface wlan0.IPv4 for mDNS. Aug 29 15:57:14 volumio avahi-daemon[429]: Registering new address record for 10.0.0.6 on wlan0.IPv4. Aug 29 15:57:14 volumio dhcpcd[451]: forked to background, child pid 822 Aug 29 15:57:14 volumio dhcpcd[451]: forked to background, child pid 822 Aug 29 15:57:14 volumio systemd[1]: Started DHCP Client Daemon. Aug 29 15:57:15 volumio wireless.js[438]: trying... Aug 29 15:57:15 volumio sudo[824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 29 15:57:15 volumio sudo[824]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:15 volumio sudo[824]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:15 volumio wireless.js[438]: Connected to: ----pre26set45 Aug 29 15:57:15 volumio wireless.js[438]: ---- Aug 29 15:57:15 volumio sudo[829]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 15:57:15 volumio sudo[829]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:15 volumio sudo[829]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:15 volumio wireless.js[438]: ... joined AP, wlan0 IPv4 is 10.0.0.6, ipV6 is undefined Aug 29 15:57:15 volumio wireless.js[438]: It's done! AP Aug 29 15:57:15 volumio systemd[1]: Started Wireless Services. Aug 29 15:57:15 volumio systemd[1]: Started Volumio Backend Module. Aug 29 15:57:15 volumio systemd[1]: Started Volumio Streaming Daemon. Aug 29 15:57:15 volumio volumio-streaming-daemon[836]: ############################ Aug 29 15:57:15 volumio volumio-streaming-daemon[836]: # Volumio Streaming Daemon # Aug 29 15:57:15 volumio volumio-streaming-daemon[836]: # Running on port 7777 # Aug 29 15:57:15 volumio volumio-streaming-daemon[836]: ############################ Aug 29 15:57:15 volumio volumio-streaming-daemon[836]: Environment: production Aug 29 15:57:15 volumio nmbd[628]: [2023/08/29 15:57:15.906627, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 29 15:57:15 volumio nmbd[628]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 29 15:57:15 volumio systemd[1]: Started Samba NMB Daemon. Aug 29 15:57:15 volumio systemd[1]: Starting Samba Winbind Daemon... Aug 29 15:57:16 volumio ntpd[661]: Listen normally on 2 wlan0 10.0.0.6:123 Aug 29 15:57:16 volumio ntpd[661]: new interface(s) found: waking up resolver Aug 29 15:57:16 volumio winbindd[852]: [2023/08/29 15:57:16.205074, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 29 15:57:16 volumio winbindd[852]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 29 15:57:16 volumio winbindd[852]: [2023/08/29 15:57:16.219223, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 29 15:57:16 volumio systemd[1]: Started Samba Winbind Daemon. Aug 29 15:57:16 volumio winbindd[852]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 29 15:57:16 volumio systemd[1]: Starting Samba SMB Daemon... Aug 29 15:57:16 volumio winbindd[852]: [2023/08/29 15:57:16.841022, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Aug 29 15:57:16 volumio winbindd[852]: res_names->count = 3, expected 4 Aug 29 15:57:16 volumio smbd[860]: [2023/08/29 15:57:16.863629, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 29 15:57:16 volumio systemd[1]: Started Samba SMB Daemon. Aug 29 15:57:16 volumio smbd[860]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 29 15:57:16 volumio systemd[1]: Reached target Multi-User System. Aug 29 15:57:16 volumio systemd[1]: Reached target Graphical Interface. Aug 29 15:57:16 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 29 15:57:16 volumio smbd[860]: [2023/08/29 15:57:16.891743, 0] ../source3/lib/util_sock.c:334(open_socket_in) Aug 29 15:57:16 volumio smbd[860]: open_socket_in(): socket() call failed: Address family not supported by protocol Aug 29 15:57:16 volumio smbd[860]: [2023/08/29 15:57:16.892266, 0] ../source3/smbd/server.c:1094(smbd_open_one_socket) Aug 29 15:57:16 volumio smbd[860]: smbd_open_one_socket: open_socket_in: Address family not supported by protocol Aug 29 15:57:16 volumio smbd[860]: [2023/08/29 15:57:16.909835, 0] ../source3/lib/util_sock.c:334(open_socket_in) Aug 29 15:57:16 volumio smbd[860]: open_socket_in(): socket() call failed: Address family not supported by protocol Aug 29 15:57:16 volumio smbd[860]: [2023/08/29 15:57:16.910056, 0] ../source3/smbd/server.c:1094(smbd_open_one_socket) Aug 29 15:57:16 volumio smbd[860]: smbd_open_one_socket: open_socket_in: Address family not supported by protocol Aug 29 15:57:16 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 29 15:57:16 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 29 15:57:16 volumio systemd[1]: Startup finished in 10.920s (kernel) + 18.040s (userspace) = 28.961s. Aug 29 15:57:17 volumio volumio-remote-updater[439]: [2023-08-29 15:57:17] [info] asio async_connect error: system:111 (Connection refused) Aug 29 15:57:17 volumio volumio-remote-updater[439]: [2023-08-29 15:57:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 29 15:57:17 volumio volumio-remote-updater[439]: [2023-08-29 15:57:17] [error] handle_connect error: Underlying Transport Error Aug 29 15:57:18 volumio volumio[835]: info: ------------------------------------------- Aug 29 15:57:18 volumio volumio[835]: info: ----- Volumio3 ---- Aug 29 15:57:18 volumio volumio[835]: info: ------------------------------------------- Aug 29 15:57:18 volumio volumio[835]: info: ----- System startup ---- Aug 29 15:57:18 volumio volumio[835]: info: ------------------------------------------- Aug 29 15:57:19 volumio volumio[835]: info: MYVOLUMIO Environment detected Aug 29 15:57:19 volumio volumio[835]: info: Plugin folders cleanup Aug 29 15:57:19 volumio volumio[835]: info: Scanning into folder /volumio/app/plugins/ Aug 29 15:57:19 volumio volumio[835]: info: Scanning category audio_interface Aug 29 15:57:19 volumio volumio[835]: info: Scanning category miscellanea Aug 29 15:57:19 volumio volumio[835]: info: Scanning category music_service Aug 29 15:57:19 volumio volumio[835]: info: Scanning category plugins.json Aug 29 15:57:19 volumio volumio[835]: info: Scanning category system_controller Aug 29 15:57:19 volumio volumio[835]: info: Scanning category user_interface Aug 29 15:57:19 volumio volumio[835]: info: Scanning into folder /data/plugins/ Aug 29 15:57:19 volumio volumio[835]: info: Plugin folders cleanup completed Aug 29 15:57:19 volumio volumio[835]: info: ------------------------------------------- Aug 29 15:57:19 volumio volumio[835]: info: ----- Core plugins startup ---- Aug 29 15:57:19 volumio volumio[835]: info: ------------------------------------------- Aug 29 15:57:19 volumio volumio[835]: info: Loading plugins from folder /volumio/app/plugins/ Aug 29 15:57:19 volumio volumio[835]: info: Adding plugin upnp to MyMusic Plugins Aug 29 15:57:19 volumio volumio[835]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 29 15:57:19 volumio volumio[835]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 29 15:57:19 volumio volumio[835]: info: Loading plugins from folder /data/plugins/ Aug 29 15:57:19 volumio volumio[835]: info: Loading plugin "system"... Aug 29 15:57:19 volumio volumio[835]: info: Loading plugin "appearance"... Aug 29 15:57:20 volumio volumio[835]: info: Loading plugin "network"... Aug 29 15:57:20 volumio volumio[835]: info: Refreshing Cached IP Addresses Aug 29 15:57:20 volumio sudo[890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 15:57:20 volumio sudo[890]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:20 volumio sudo[890]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:20 volumio volumio[835]: info: Loading plugin "services"... Aug 29 15:57:20 volumio volumio[835]: info: Loading plugin "alsa_controller"... Aug 29 15:57:20 volumio sudo[894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 15:57:20 volumio sudo[894]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:20 volumio sudo[894]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:20 volumio sudo[899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 29 15:57:20 volumio sudo[899]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:21 volumio volumio[835]: info: Loading plugin "wizard"... Aug 29 15:57:21 volumio volumio[835]: info: Loading plugin "volumio_command_line_client"... Aug 29 15:57:21 volumio volumio[835]: info: Loading plugin "upnp"... Aug 29 15:57:21 volumio volumio[835]: info: [1693324641044] Starting Upmpd Daemon Aug 29 15:57:21 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 29 15:57:21 volumio volumio[835]: info: Loading plugin "my_music"... Aug 29 15:57:21 volumio volumio[835]: info: Loading plugin "mpd"... Aug 29 15:57:21 volumio volumio[835]: info: Creating MPD Configuration file Aug 29 15:57:21 volumio volumio[835]: info: Loading plugin "upnp_browser"... Aug 29 15:57:21 volumio sudo[909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 15:57:21 volumio sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:21 volumio sudo[909]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:21 volumio sudo[913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 15:57:21 volumio sudo[913]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:21 volumio systemd[1]: Stopping Music Player Daemon... Aug 29 15:57:21 volumio systemd[1]: mpd.service: Succeeded. Aug 29 15:57:21 volumio systemd[1]: Stopped Music Player Daemon. Aug 29 15:57:21 volumio systemd[1]: Starting Music Player Daemon... Aug 29 15:57:22 volumio volumio[835]: info: Loading plugin "networkfs"... Aug 29 15:57:22 volumio volumio[835]: info: Starting Udev Watcher for removable devices Aug 29 15:57:22 volumio volumio[835]: info: Ignoring mount for partition: boot Aug 29 15:57:22 volumio volumio[835]: info: Ignoring mount for partition: volumio Aug 29 15:57:22 volumio volumio[835]: info: Ignoring mount for partition: volumio_data Aug 29 15:57:22 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 29 15:57:22 volumio volumio[835]: info: Loading plugin "alarm-clock"... Aug 29 15:57:22 volumio volumio[835]: info: Loading plugin "airplay_emulation"... Aug 29 15:57:22 volumio volumio[835]: info: Starting Shairport Sync Aug 29 15:57:22 volumio volumio[835]: info: Loading plugin "last_100"... Aug 29 15:57:22 volumio volumio[835]: info: Loading plugin "webradio"... Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "i2s_dacs"... Aug 29 15:57:23 volumio volumio[835]: info: I2S DAC not set, start Auto-detection Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "volumiodiscovery"... Aug 29 15:57:23 volumio volumio[835]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 29 15:57:23 volumio node[835]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 29 15:57:23 volumio volumio[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 15:57:23 volumio node[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 15:57:23 volumio volumio[835]: *** WARNING *** For more information see Aug 29 15:57:23 volumio node[835]: *** WARNING *** For more information see Aug 29 15:57:23 volumio volumio[835]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 29 15:57:23 volumio node[835]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 29 15:57:23 volumio volumio[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 15:57:23 volumio node[835]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 15:57:23 volumio volumio[835]: *** WARNING *** For more information see Aug 29 15:57:23 volumio node[835]: *** WARNING *** For more information see Aug 29 15:57:23 volumio volumio[835]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 29 15:57:23 volumio volumio[835]: info: Discovery: Started advertising with name: Volumio Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "outputs"... Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "albumart"... Aug 29 15:57:23 volumio volumio[835]: info: Plugin example_plugin is not enabled Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "inputs"... Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "updater_comm"... Aug 29 15:57:23 volumio mpd[923]: Aug 29 15:57 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 29 15:57:23 volumio volumio[835]: info: Plugin mpdemulation is not enabled Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "rest_api"... Aug 29 15:57:23 volumio volumio[835]: info: Loading plugin "websocket"... Aug 29 15:57:23 volumio volumio[835]: info: Loading i18n strings for locale en Aug 29 15:57:23 volumio volumio[835]: Updating browse sources language Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::initPlayerControls Aug 29 15:57:23 volumio mpd[923]: Aug 29 15:57 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Aug 29 15:57:23 volumio mpd[923]: Aug 29 15:57 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 29 15:57:23 volumio systemd[1]: Started Music Player Daemon. Aug 29 15:57:23 volumio sudo[913]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:23 volumio volumio[835]: Express server listening on port 3000 Aug 29 15:57:23 volumio volumio[835]: [Metrics] WebUI: 6s 308.23ms Aug 29 15:57:23 volumio volumio[835]: info: CoreStateMachine::resetVolumioState Aug 29 15:57:23 volumio volumio[835]: info: CoreStateMachine::getcurrentVolume Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::volumioRetrievevolume Aug 29 15:57:23 volumio volumio[835]: info: CoreStateMachine::pushState Aug 29 15:57:23 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Aug 29 15:57:23 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:23 volumio volumio[835]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 29 15:57:23 volumio volumio[835]: info: Completed loading Core Plugins Aug 29 15:57:23 volumio volumio[835]: info: Preparing to generate the ALSA configuration file Aug 29 15:57:23 volumio volumio[835]: Forking 3 albumart workers Aug 29 15:57:23 volumio volumio[835]: info: MPD Permissions set Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: Reloading queue from file Aug 29 15:57:24 volumio volumio[835]: error: updateQueue error: null Aug 29 15:57:24 volumio volumio[835]: info: MPD running with PID923 Aug 29 15:57:24 volumio volumio[835]: ,establishing connection Aug 29 15:57:24 volumio volumio[835]: info: Asound.conf file unchanged, so no further update is needed Aug 29 15:57:24 volumio volumio[835]: info: Output device has changed, restarting MPD Aug 29 15:57:24 volumio volumio[835]: info: Output device has changed, restarting Shairport Sync Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:24 volumio sudo[980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 15:57:24 volumio sudo[980]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:24 volumio sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 15:57:24 volumio sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:24 volumio systemd[1]: Stopping Music Player Daemon... Aug 29 15:57:24 volumio volumio[835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 15:57:24 volumio volumio[835]: info: ___________ START PLUGINS ___________ Aug 29 15:57:24 volumio sudo[979]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 15:57:24 volumio volumio[835]: info: [1693324644478] CoreMusicLibrary::Adding element Media Servers Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 15:57:24 volumio volumio[835]: Cannot find translation for sourceMedia Servers Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:24 volumio systemd[1]: mpd.service: Succeeded. Aug 29 15:57:24 volumio systemd[1]: Stopped Music Player Daemon. Aug 29 15:57:24 volumio systemd[1]: Starting Music Player Daemon... Aug 29 15:57:24 volumio volumio[835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 15:57:24 volumio volumio[835]: info: [1693324644669] CoreMusicLibrary::Adding element Last_100 Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 15:57:24 volumio volumio[835]: Cannot find translation for sourceMedia Servers Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 15:57:24 volumio volumio[835]: info: [1693324644674] CoreMusicLibrary::Adding element Webradio Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 15:57:24 volumio volumio[835]: Cannot find translation for sourceMedia Servers Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 15:57:24 volumio volumio[835]: info: Volumio Calling Home Aug 29 15:57:24 volumio volumio[835]: info: Completed starting Core Plugins Aug 29 15:57:24 volumio volumio[835]: info: ------------------------------------------- Aug 29 15:57:24 volumio volumio[835]: info: ----- MyVolumio plugins startup ---- Aug 29 15:57:24 volumio volumio[835]: info: ------------------------------------------- Aug 29 15:57:24 volumio volumio[835]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 29 15:57:24 volumio volumio[835]: Starting albumart workers Aug 29 15:57:24 volumio volumio[835]: info: CoreStateMachine::setRepeat null single undefined Aug 29 15:57:24 volumio volumio[835]: info: CoreStateMachine::pushState Aug 29 15:57:24 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Aug 29 15:57:24 volumio volumio[835]: info: CoreStateMachine::setRandom null Aug 29 15:57:24 volumio volumio[835]: info: CoreStateMachine::pushState Aug 29 15:57:24 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Aug 29 15:57:24 volumio volumio[835]: info: CoreCommandRouter::volumioPushState Aug 29 15:57:24 volumio volumio[835]: info: Setting Device type: Odroid-C2 Aug 29 15:57:25 volumio volumio[835]: error: MPD error: Error: write EPIPE Aug 29 15:57:25 volumio volumio[835]: info: MPD Permissions set Aug 29 15:57:25 volumio volumio[835]: Starting albumart workers Aug 29 15:57:25 volumio volumio[835]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 29 15:57:25 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:25 volumio volumio[835]: info: Starting Shairport Sync Aug 29 15:57:25 volumio volumio[835]: Starting albumart workers Aug 29 15:57:25 volumio volumio[835]: info: Starting Shairport Sync Aug 29 15:57:25 volumio volumio[835]: info: Starting Shairport Sync Aug 29 15:57:25 volumio sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 15:57:25 volumio sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:25 volumio sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 15:57:25 volumio sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 29 15:57:25 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 29 15:57:25 volumio sudo[1020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 15:57:25 volumio sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 29 15:57:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 29 15:57:25 volumio sudo[1013]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:25 volumio volumio[835]: info: Shairport-Sync Started Aug 29 15:57:25 volumio volumio[835]: Error adding Membership: Error: addMembership EINVAL Aug 29 15:57:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 29 15:57:25 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 29 15:57:25 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 29 15:57:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 29 15:57:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 29 15:57:25 volumio sudo[1019]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:25 volumio volumio[835]: info: Shairport-Sync Started Aug 29 15:57:25 volumio sudo[1020]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:25 volumio volumio[835]: info: Shairport-Sync Started Aug 29 15:57:26 volumio mpd[1015]: Aug 29 15:57 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 29 15:57:26 volumio mpd[1015]: Aug 29 15:57 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Aug 29 15:57:26 volumio mpd[1015]: Aug 29 15:57 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Aug 29 15:57:26 volumio systemd[1]: Started Music Player Daemon. Aug 29 15:57:26 volumio sudo[980]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:26 volumio volumio[835]: error: updateQueue error: null Aug 29 15:57:27 volumio volumio-remote-updater[439]: [2023-08-29 15:57:27] [connect] Successful connection Aug 29 15:57:27 volumio volumio-remote-updater[439]: [2023-08-29 15:57:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1693324647 101 Aug 29 15:57:27 volumio volumio[835]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Aug 29 15:57:27 volumio sudo[899]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:30 volumio volumio[835]: error: updateQueue error: null Aug 29 15:57:30 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Aug 29 15:57:30 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Aug 29 15:57:30 volumio volumio[835]: info: Volumio called home Aug 29 15:57:31 volumio sudo[1069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 15:57:31 volumio sudo[1069]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:31 volumio sudo[1069]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:31 volumio sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 15:57:31 volumio sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:31 volumio sudo[1071]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:31 volumio sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 29 15:57:31 volumio sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:31 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 29 15:57:31 volumio sudo[1078]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:31 volumio volumio[835]: info: Upmpdcli Daemon Started Aug 29 15:57:31 volumio volumio[1083]: Generating RSA private key, 4096 bit long modulus (2 primes) Aug 29 15:57:32 volumio systemd[1]: systemd-fsckd.service: Succeeded. Aug 29 15:57:32 volumio sh[302]: timed out Aug 29 15:57:32 volumio dhcpcd[354]: timed out Aug 29 15:57:32 volumio sh[302]: dhcpcd exited Aug 29 15:57:32 volumio dhcpcd[354]: dhcpcd exited Aug 29 15:57:32 volumio sh[302]: ifup: failed to bring up eth0 Aug 29 15:57:32 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Aug 29 15:57:32 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Aug 29 15:57:33 volumio volumio[1083]: ......................................++++ Aug 29 15:57:39 volumio volumio[835]: info: Discovery: adding 3973994d-d1d7-4c45-8ea6-2b676496bb7f Aug 29 15:57:39 volumio volumio[835]: info: mDNS: Found device Volumio Aug 29 15:57:40 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Aug 29 15:57:40 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Aug 29 15:57:44 volumio volumio[1083]: ...........................................................................................................................................................++++ Aug 29 15:57:44 volumio volumio[1083]: e is 65537 (0x010001) Aug 29 15:57:44 volumio volumio[1083]: writing RSA key Aug 29 15:57:44 volumio volumio[835]: error: MyVolumio Plugin failed to start in a timely fashion Aug 29 15:57:44 volumio volumio[835]: info: BOOT COMPLETED Aug 29 15:57:44 volumio volumio[835]: [Metrics] CommandRouter: 26s 659.29ms Aug 29 15:57:44 volumio volumio[835]: info: CoreCommandRouter::volumiosetStartupVolume Aug 29 15:57:44 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 15:57:44 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:44 volumio volumio[835]: info: CoreCommandRouter::Close All Modals sent Aug 29 15:57:44 volumio volumio[835]: info: CoreCommandRouter::Close All Modals sent Aug 29 15:57:44 volumio kernel: divider=17,frac=80768000,SDMval=11722 Aug 29 15:57:44 volumio kernel: [aml-i2s-dai]i2s dma ffffff8007789000,phy addr 1574699008,mode 0,ch 2 Aug 29 15:57:44 volumio kernel: ----aml_hw_iec958_init,runtime->rate=44100,sample_rate=5-- Aug 29 15:57:44 volumio kernel: aml_set_spdif_clk rate Aug 29 15:57:44 volumio kernel: share the same clock Aug 29 15:57:44 volumio kernel: iec958 mode PCM16 Aug 29 15:57:44 volumio kernel: IEC958 16bit Aug 29 15:57:44 volumio kernel: hdmitx: audio: aout notify rate 44100 Aug 29 15:57:44 volumio kernel: hdmitx: audio: aout notify size 16 Aug 29 15:57:44 volumio kernel: hdmtix: set audio Aug 29 15:57:44 volumio kernel: hdmitx tx_aud_src = 0 Aug 29 15:57:44 volumio kernel: hdmitx aud_n_para = 6144 Aug 29 15:57:44 volumio kernel: hdmitx set channel status Aug 29 15:57:44 volumio kernel: 958 with i2s Aug 29 15:57:44 volumio kernel: aiu i2s playback enable Aug 29 15:57:45 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 29 15:57:45 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 29 15:57:45 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 29 15:57:50 volumio kernel: aiu i2s playback disable Aug 29 15:57:50 volumio kernel: audio_hw_958_enable 0 Aug 29 15:57:51 volumio sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 15:57:51 volumio sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:51 volumio sudo[1138]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:51 volumio sudo[1142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 15:57:51 volumio sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:57:51 volumio sudo[1142]: pam_unix(sudo:session): session closed for user root Aug 29 15:57:51 volumio volumio[835]: verbose: New Socket.io Connection to 10.0.0.6 from 10.0.0.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/130.0.0.0 Safari/537.36 Total Clients: 3 Aug 29 15:57:51 volumio volumio[835]: info: CoreCommandRouter::volumioGetState Aug 29 15:57:51 volumio volumio[835]: info: CorePlayQueue::getTrack 0 Aug 29 15:57:52 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 29 15:57:52 volumio volumio[835]: info: CoreCommandRouter::volumioGetVisibleSources Aug 29 15:57:52 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 15:57:52 volumio volumio[835]: info: Listing playlists Aug 29 15:57:52 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 29 15:57:52 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 29 15:57:52 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 29 15:57:52 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 29 15:57:54 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 15:57:54 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 15:57:54 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 15:57:56 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 15:57:56 volumio volumio[835]: info: CURURI: music-library Aug 29 15:57:56 volumio volumio[835]: info: CoreCommandRouter::volumioGetQueue Aug 29 15:57:56 volumio volumio[835]: info: CoreStateMachine::getQueue Aug 29 15:57:56 volumio volumio[835]: info: CorePlayQueue::getQueue Aug 29 15:57:58 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 15:57:58 volumio volumio[835]: info: CURURI: music-library/USB Aug 29 15:57:59 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 15:57:59 volumio volumio[835]: info: CURURI: music-library/USB/9C583B30583B0912 Aug 29 15:58:00 volumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 15:58:00 volumio volumio[835]: info: CURURI: music-library/USB/9C583B30583B0912/Music Aug 29 15:58:04 volumio volumio[835]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 15:58:05 volumio volumio[835]: Error: certificate is not yet valid Aug 29 15:58:05 volumio volumio[835]: at TLSSocket.onConnectSecure (_tls_wrap.js:1515:34) Aug 29 15:58:05 volumio volumio[835]: at TLSSocket.emit (events.js:400:28) Aug 29 15:58:05 volumio volumio[835]: at TLSSocket._finishInit (_tls_wrap.js:937:8) Aug 29 15:58:05 volumio volumio[835]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:709:12) { Aug 29 15:58:05 volumio volumio[835]: code: 'CERT_NOT_YET_VALID' Aug 29 15:58:05 volumio volumio[835]: } Aug 29 15:58:05 volumio volumio[835]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 15:58:05 volumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-08-29 15:57 Aug 29 15:58:05 volumio sudo[1162]: 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="613d705c083fd29de3027cf6e63a923a6020da8e" VOLUMIO_FE_VERSION="575f38b17bfc836dbd47f560a440d36ecd98d5af" VOLUMIO_FE3_VERSION="af818e7eb038d49989134ddd7bf2b2ffaa8cf083" VOLUMIO_BE_VERSION="5936439c04ed803864b9ef314729c659b841752e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 28 Jan 2022 10:04:45 PM CET" VOLUMIO_VERSION="3.212" VOLUMIO_HARDWARE="odroidc2" VOLUMIO_DEVICENAME="Odroid-C2" VOLUMIO_HASH="e60fcd6411bb7741c04d22a66ac9ecc2"