-- Logs begin at Sat 2024-10-19 19:09:25 MSK, end at Sat 2024-10-19 19:09:45 MSK. -- Oct 19 19:09:25 volumio kernel: Booting Linux on physical CPU 0x0 Oct 19 19:09:25 volumio kernel: Linux version 4.9.241+ (odroidc4@busteros) (gcc version 6.3.1 20170109 (Linaro GCC 6.3-2017.02) ) #15 SMP PREEMPT Thu Feb 10 11:27:37 CET 2022 Oct 19 19:09:25 volumio kernel: Boot CPU: AArch64 Processor [411fd050] Oct 19 19:09:25 volumio kernel: Machine model: Hardkernel ODROID-C4 Oct 19 19:09:25 volumio kernel: efi: Getting EFI parameters from FDT: Oct 19 19:09:25 volumio kernel: efi: UEFI not found. Oct 19 19:09:25 volumio kernel: 07400000 - 07500000, 1024 KB, ramoops@0x07400000 Oct 19 19:09:25 volumio kernel: __reserved_mem_alloc_size, start:0x0000000005000000, end:0x0000000005400000, len:4 MiB Oct 19 19:09:25 volumio kernel: 05000000 - 05400000, 4096 KB, linux,secmon Oct 19 19:09:25 volumio kernel: Reserved memory: created DMA memory pool at 0x00000000ed800000, size 0 MiB Oct 19 19:09:25 volumio kernel: ed800000 - ed800000, 0 KB, linux,ppmgr Oct 19 19:09:25 volumio kernel: __reserved_mem_alloc_size, start:0x000000007f800000, end:0x0000000080000000, len:8 MiB Oct 19 19:09:25 volumio kernel: 7f800000 - 80000000, 8192 KB, linux,meson-fb Oct 19 19:09:25 volumio kernel: e5800000 - ed800000, 131072 KB, linux,ion-dev Oct 19 19:09:25 volumio kernel: e3000000 - e5800000, 40960 KB, linux,di_cma Oct 19 19:09:25 volumio kernel: cfc00000 - e3000000, 315392 KB, linux,codec_mm_cma Oct 19 19:09:25 volumio kernel: cfc00000 - cfc00000, 0 KB, linux,codec_mm_reserved Oct 19 19:09:25 volumio kernel: cma: Reserved 8 MiB at 0x00000000cf400000 Oct 19 19:09:25 volumio kernel: On node 0 totalpages: 972800 Oct 19 19:09:25 volumio kernel: DMA zone: 15200 pages used for memmap Oct 19 19:09:25 volumio kernel: DMA zone: 0 pages reserved Oct 19 19:09:25 volumio kernel: DMA zone: 972800 pages, LIFO batch:31 Oct 19 19:09:25 volumio kernel: psci: probing for conduit method from DT. Oct 19 19:09:25 volumio kernel: psci: PSCIv1.0 detected in firmware. Oct 19 19:09:25 volumio kernel: psci: Using standard PSCI v0.2 function IDs Oct 19 19:09:25 volumio kernel: psci: MIGRATE_INFO_TYPE not supported. Oct 19 19:09:25 volumio kernel: psci: SMC Calling Convention v1.1 Oct 19 19:09:25 volumio kernel: percpu: Embedded 21 pages/cpu s47960 r8192 d29864 u86016 Oct 19 19:09:25 volumio kernel: pcpu-alloc: s47960 r8192 d29864 u86016 alloc=21*4096 Oct 19 19:09:25 volumio kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 19 19:09:25 volumio kernel: Detected VIPT I-cache on CPU0 Oct 19 19:09:25 volumio kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 957600 Oct 19 19:09:25 volumio kernel: Kernel command line: imgpart=UUID=a9460194-3ef9-4999-a761-00243d755aa0 bootpart=UUID=1E7D-6AB2 datapart=UUID=41226ca2-7237-43ba-92a6-12e223cdac70 imgfile=/volumio_current.sqsh uuidconfig=boot.ini quiet loglevel=0 splash plymouth.ignore-serial-consoles initramfs.clear hwdevice=Odroid-C4 bootdelay=5 console=ttyS0,115200n8 no_console_suspend fsck.repair=yes net.ifnames=0 elevator=noop hdmimode=custombuilt cvbsmode=576cvbs max_freq_a55=1908 maxcpus=4 voutmode=hdmi modeline=2560,1440,241500,88786,60,2560,2608,2640,2720,1440,1443,1448,1481,1,1,1 disablehpd=false cvbscable= overscan=100 monitor_onoff=false logo=osd0,loaded sdrmode=auto enable_wol=0 Oct 19 19:09:25 volumio kernel: vout: get hdmimode: custombuilt Oct 19 19:09:25 volumio kernel: vout: get cvbsmode: 576cvbs Oct 19 19:09:25 volumio kernel: max cpufreq of cluster0 : 1908000kHz Oct 19 19:09:25 volumio kernel: hdmitx: voutmode : 1 Oct 19 19:09:25 volumio kernel: fmt_para.timing Oct 19 19:09:25 volumio kernel: - pixel_freq 241500, frac_freq 241500 Oct 19 19:09:25 volumio kernel: - h_freq 88786, v_freq 60000 Oct 19 19:09:25 volumio kernel: - hsync_polarity 1, vsync_polarity 1 Oct 19 19:09:25 volumio kernel: - h_active 2560, h_total 2720 Oct 19 19:09:25 volumio kernel: - h_blank 160, h_front 48, h_sync 32, h_back 80 Oct 19 19:09:25 volumio kernel: - v_active 1440, v_total 1481 Oct 19 19:09:25 volumio kernel: - v_blank 41, v_front 3, v_sync 5, v_back 33 Oct 19 19:09:25 volumio kernel: - v_sync_ln 1 Oct 19 19:09:25 volumio kernel: fmt_para.hdmitx_vinfo Oct 19 19:09:25 volumio kernel: - name custombuilt, mode 0 Oct 19 19:09:25 volumio kernel: - width 2560, height 1440, field_height 1440 Oct 19 19:09:25 volumio kernel: - aspect_ratio_num 16, aspect_ratio_den 9 Oct 19 19:09:25 volumio kernel: - video_clk 241500000 Oct 19 19:09:25 volumio kernel: - htotal 2720, vtotal 1481 Oct 19 19:09:25 volumio kernel: - viu_color_fmt 2, viu_mux 2 Oct 19 19:09:25 volumio kernel: fb: osd0 Oct 19 19:09:25 volumio kernel: fb: loaded Oct 19 19:09:25 volumio kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Oct 19 19:09:25 volumio kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) Oct 19 19:09:25 volumio kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) Oct 19 19:09:25 volumio kernel: Memory: 3275308K/3891200K available (11964K kernel code, 1816K rwdata, 5136K rodata, 4992K init, 1421K bss, 107988K reserved, 507904K cma-reserved) Oct 19 19:09:25 volumio kernel: Virtual kernel memory layout: Oct 19 19:09:25 volumio kernel: modules : 0xffffff8000000000 - 0xffffff8008000000 ( 128 MB) Oct 19 19:09:25 volumio kernel: vmalloc : 0xffffff8008000000 - 0xffffffbebfff0000 ( 250 GB) Oct 19 19:09:25 volumio kernel: .text : 0xffffff8009080000 - 0xffffff8009c30000 ( 11968 KB) Oct 19 19:09:25 volumio kernel: .rodata : 0xffffff8009c30000 - 0xffffff800a140000 ( 5184 KB) Oct 19 19:09:25 volumio kernel: .init : 0xffffff800a140000 - 0xffffff800a620000 ( 4992 KB) Oct 19 19:09:25 volumio kernel: .data : 0xffffff800a620000 - 0xffffff800a7e6200 ( 1817 KB) Oct 19 19:09:25 volumio kernel: .bss : 0xffffff800a7e6200 - 0xffffff800a9498bc ( 1422 KB) Oct 19 19:09:25 volumio kernel: fixed : 0xffffffbefe7fd000 - 0xffffffbefec00000 ( 4108 KB) Oct 19 19:09:25 volumio kernel: PCI I/O : 0xffffffbefee00000 - 0xffffffbeffe00000 ( 16 MB) Oct 19 19:09:25 volumio kernel: vmemmap : 0xffffffbf00000000 - 0xffffffc000000000 ( 4 GB maximum) Oct 19 19:09:25 volumio kernel: 0xffffffbf00000000 - 0xffffffbf03b60000 ( 59 MB actual) Oct 19 19:09:25 volumio kernel: memory : 0xffffffc000000000 - 0xffffffc0ed800000 ( 3800 MB) Oct 19 19:09:25 volumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 19 19:09:25 volumio kernel: Preemptible hierarchical RCU implementation. Oct 19 19:09:25 volumio kernel: Build-time adjustment of leaf fanout to 64. Oct 19 19:09:25 volumio kernel: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Oct 19 19:09:25 volumio kernel: RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=4 Oct 19 19:09:25 volumio kernel: NR_IRQS:64 nr_irqs:64 0 Oct 19 19:09:25 volumio kernel: GPIO-INTC: support to detect double-edge trigger signal Oct 19 19:09:25 volumio kernel: g12a_aoclkc_init: register ao clk ok! Oct 19 19:09:25 volumio kernel: Meson chip version = RevC (2B:C - 10:0) Oct 19 19:09:25 volumio kernel: meson_g12a_sdemmc_init: register amlogic sdemmc clk Oct 19 19:09:25 volumio kernel: meson_g12a_sdemmc_init: register amlogic sdemmc clk Oct 19 19:09:25 volumio kernel: meson_g12a_gpu_init: register meson gpu clk Oct 19 19:09:25 volumio kernel: meson_g12a_media_init: register meson media clk Oct 19 19:09:25 volumio kernel: meson_g12a_misc_init: register amlogic g12a misc clks Oct 19 19:09:25 volumio kernel: meson_g12a_misc_init: done. Oct 19 19:09:25 volumio kernel: g12a_clkc_init initialization complete Oct 19 19:09:25 volumio kernel: sm1 clk probe ok Oct 19 19:09:25 volumio kernel: arm_arch_timer: Architected cp15 timer(s) running at 24.00MHz (phys). Oct 19 19:09:25 volumio kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns Oct 19 19:09:25 volumio kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns Oct 19 19:09:25 volumio kernel: meson_bc_timer: mclk->mux_reg =ffffff800800c190,mclk->reg =ffffff800800e194 Oct 19 19:09:25 volumio kernel: Console: colour dummy device 80x25 Oct 19 19:09:25 volumio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) Oct 19 19:09:25 volumio kernel: pid_max: default: 32768 minimum: 301 Oct 19 19:09:25 volumio kernel: Security Framework initialized Oct 19 19:09:25 volumio kernel: SELinux: Initializing. Oct 19 19:09:25 volumio kernel: SELinux: Starting in permissive mode Oct 19 19:09:25 volumio kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) Oct 19 19:09:25 volumio kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) Oct 19 19:09:25 volumio kernel: ftrace: allocating 39807 entries in 156 pages Oct 19 19:09:25 volumio kernel: sched-energy: CPU device node has no sched-energy-costs Oct 19 19:09:25 volumio kernel: CPU0: update cpu_capacity 1024 Oct 19 19:09:25 volumio kernel: ASID allocator initialised with 65536 entries Oct 19 19:09:25 volumio kernel: secmon: can't fine clear_range Oct 19 19:09:25 volumio kernel: EFI services will not be available. Oct 19 19:09:25 volumio kernel: Detected VIPT I-cache on CPU1 Oct 19 19:09:25 volumio kernel: CPU1: update cpu_capacity 1024 Oct 19 19:09:25 volumio kernel: CPU1: Booted secondary processor [411fd050] Oct 19 19:09:25 volumio kernel: Detected VIPT I-cache on CPU2 Oct 19 19:09:25 volumio kernel: CPU2: update cpu_capacity 1024 Oct 19 19:09:25 volumio kernel: CPU2: Booted secondary processor [411fd050] Oct 19 19:09:25 volumio kernel: Detected VIPT I-cache on CPU3 Oct 19 19:09:25 volumio kernel: CPU3: update cpu_capacity 1024 Oct 19 19:09:25 volumio kernel: CPU3: Booted secondary processor [411fd050] Oct 19 19:09:25 volumio kernel: Brought up 4 CPUs Oct 19 19:09:25 volumio kernel: SMP: Total of 4 processors activated. Oct 19 19:09:25 volumio kernel: CPU features: detected feature: Privileged Access Never Oct 19 19:09:25 volumio kernel: CPU features: detected feature: User Access Override Oct 19 19:09:25 volumio kernel: CPU features: detected feature: 32-bit EL0 Support Oct 19 19:09:25 volumio kernel: CPU: All CPU(s) started at EL2 Oct 19 19:09:25 volumio kernel: alternatives: patching kernel code Oct 19 19:09:25 volumio kernel: devtmpfs: initialized Oct 19 19:09:25 volumio kernel: DMI not present or invalid. Oct 19 19:09:25 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Oct 19 19:09:25 volumio kernel: futex hash table entries: 1024 (order: 4, 65536 bytes) Oct 19 19:09:25 volumio kernel: pinctrl core: initialized pinctrl subsystem Oct 19 19:09:25 volumio kernel: NET: Registered protocol family 16 Oct 19 19:09:25 volumio kernel: schedtune: init normalization constants... Oct 19 19:09:25 volumio kernel: schedtune: no energy model data Oct 19 19:09:25 volumio kernel: schedtune: disabled! Oct 19 19:09:25 volumio kernel: cpuidle: using governor menu Oct 19 19:09:25 volumio kernel: register canvas platform driver Oct 19 19:09:25 volumio kernel: register rdma platform driver Oct 19 19:09:25 volumio kernel: vdso: 2 pages (1 code @ ffffff8009c37000, 1 data @ ffffff800a625000) Oct 19 19:09:25 volumio kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 19 19:09:25 volumio kernel: DMA: preallocated 2048 KiB pool for atomic allocations Oct 19 19:09:25 volumio kernel: clkmsr: clkmsr: driver init Oct 19 19:09:25 volumio kernel: codec_mm_module_init Oct 19 19:09:25 volumio kernel: media_configs_system_init Oct 19 19:09:25 volumio kernel: pstore: using zlib compression Oct 19 19:09:25 volumio kernel: console [pstore-1] enabled Oct 19 19:09:25 volumio kernel: pstore: Registered ramoops as persistent store backend Oct 19 19:09:25 volumio kernel: ramoops: attached 0x100000@0x7400000, ecc: 0/0 Oct 19 19:09:25 volumio kernel: aml_iomap: amlogic iomap probe done Oct 19 19:09:25 volumio kernel: vpu: driver version: v20190329(10-sm1) Oct 19 19:09:25 volumio kernel: vpu: load vpu_clk: 666666667Hz(7) Oct 19 19:09:25 volumio kernel: vpu: clktree_init Oct 19 19:09:25 volumio kernel: vpu: vpu_probe OK Oct 19 19:09:25 volumio kernel: clkmsr: msr_clk_reg0=ffffff8008453004,msr_clk_reg2=ffffff800845500c Oct 19 19:09:25 volumio kernel: clkmsr: msr_ring_reg0=ffffff80084575fc Oct 19 19:09:25 volumio kernel: audio_clocks: audio_clocks_probe done Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[0], reg:ff661000, size:400 Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[1], reg:ff660000, size:1000 Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[2], reg:ff661400, size:400 Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[3], reg:ff662000, size:1000 Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[4], reg:ffd01000, size:1000 Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[5], reg:ff661800, size:400 Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[6], reg:ff661c00, size:104 Oct 19 19:09:25 volumio kernel: aml_snd_reg_map[7], reg:ff664000, size:104 Oct 19 19:09:25 volumio kernel: amlogic auge_snd_iomap probe done Oct 19 19:09:25 volumio kernel: aml_vdac_config_probe: cpu_id:6, name:meson-sm1-vdac Oct 19 19:09:25 volumio kernel: aml_vdac_probe: ok Oct 19 19:09:25 volumio kernel: canvas_probe reg=00000000ff638000,size=2000 Oct 19 19:09:25 volumio kernel: canvas maped reg_base =ffffff800846c000 Oct 19 19:09:25 volumio kernel: rdma_probe,cpu_type:1, ver:0, len:8 Oct 19 19:09:25 volumio kernel: rdma_register, rdma_table_addr ffffff80084a1000 rdma_table_addr_phy cf600000 reg_buf ffffffc0ca210000 Oct 19 19:09:25 volumio kernel: rdma_register success, handle 1 table_size 32768 Oct 19 19:09:25 volumio kernel: set_rdma_handle video rdma handle = 1. Oct 19 19:09:25 volumio kernel: classs created ok Oct 19 19:09:25 volumio kernel: classs file created ok Oct 19 19:09:25 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma Oct 19 19:09:25 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma Oct 19 19:09:25 volumio kernel: codec_mm_probe ok Oct 19 19:09:25 volumio kernel: cvbs_out: cvbsout_probe, cpu_id:7,name:meson-sm1-cvbsout Oct 19 19:09:25 volumio kernel: cvbs_out: clk path:0 Oct 19 19:09:25 volumio kernel: cvbs_out: error: failed to get vdac_config Oct 19 19:09:25 volumio kernel: vout: vout1: register server: cvbs_vout_server Oct 19 19:09:25 volumio kernel: cvbs_out: register cvbs module server ok Oct 19 19:09:25 volumio kernel: vout: vout2: register server: cvbs_vout2_server Oct 19 19:09:25 volumio kernel: cvbs_out: register cvbs module vout2 server ok Oct 19 19:09:25 volumio kernel: cvbs_out: chrdev devno 264241152 for disp Oct 19 19:09:25 volumio kernel: cvbs_out: create cdev cvbs Oct 19 19:09:25 volumio kernel: cvbs_out: cvbsout_probe OK Oct 19 19:09:25 volumio kernel: SCSI subsystem initialized Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver usbfs Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver hub Oct 19 19:09:25 volumio kernel: usbcore: registered new device driver usb Oct 19 19:09:25 volumio kernel: media: Linux media interface: v0.10 Oct 19 19:09:25 volumio kernel: Linux video capture interface: v2.00 Oct 19 19:09:25 volumio kernel: pps_core: LinuxPPS API ver. 1 registered Oct 19 19:09:25 volumio kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 19 19:09:25 volumio kernel: PTP clock support registered Oct 19 19:09:25 volumio kernel: dmi: Firmware registration failed. Oct 19 19:09:25 volumio kernel: secmon: reserve_mem_size:0x300000 Oct 19 19:09:25 volumio kernel: secmon secmon: assigned reserved memory node linux,secmon Oct 19 19:09:25 volumio kernel: secmon: get page:ffffffbf00140000, 5000 Oct 19 19:09:25 volumio kernel: secmon: share in base: 0xffffffc0050fe000, share out base: 0xffffffc0050ff000 Oct 19 19:09:25 volumio kernel: secmon: phy_in_base: 0x50fe000, phy_out_base: 0x50ff000 Oct 19 19:09:25 volumio kernel: hdmitx: system: amhdmitx_probe start Oct 19 19:09:25 volumio kernel: hdmitx: system: Ver: 20190815 Oct 19 19:09:25 volumio kernel: hdmitx: system: hdmitx_device.chip_type : 12 Oct 19 19:09:25 volumio kernel: hdmitx: system: not find match pwr-ctl Oct 19 19:09:25 volumio kernel: hdmitx: system: not find drm_amhdmitx Oct 19 19:09:25 volumio kernel: hdmitx: system: hpd irq = 37 Oct 19 19:09:25 volumio kernel: hdmitx: system: hdcp22_tx_skp failed to probe Oct 19 19:09:25 volumio kernel: hdmitx: system: hdcp22_tx_esm failed to probe Oct 19 19:09:25 volumio kernel: vout: vout1: register server: hdmitx_vout_server Oct 19 19:09:25 volumio kernel: vout: vout2: register server: hdmitx_vout2_server Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xffd00000 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff634400 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff900000 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff800000 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff63c000 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xffd00000 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff608000 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff600000 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xffe01000 Oct 19 19:09:25 volumio kernel: hdmitx: hw: alread display in uboot 0x10 Oct 19 19:09:25 volumio kernel: hdmitx: hw: avmute set to 1 Oct 19 19:09:25 volumio kernel: hdmitx: system: fmt_attr 444,8bit Oct 19 19:09:25 volumio kernel: hdmitx: system: fmt_attr 444,8bit Oct 19 19:09:25 volumio kernel: hdmitx: system: amhdmitx_probe end Oct 19 19:09:25 volumio kernel: vout: create vout attribute OK Oct 19 19:09:25 volumio kernel: hdmitx: system: irq 80000002 0 Oct 19 19:09:25 volumio kernel: vout: vout_fops_create OK Oct 19 19:09:25 volumio kernel: vout: vout1: register server: nulldisp_vout_server Oct 19 19:09:25 volumio kernel: vout: tvout monitor interval:500(ms), timeout cnt:20 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx_set_current_vmode[3877] Oct 19 19:09:25 volumio kernel: hdmitx: system: recalc before custombuilt 60 1 Oct 19 19:09:25 volumio kernel: hdmitx: system: recalc after custombuilt 60 1 Oct 19 19:09:25 volumio kernel: hdmitx: system: get current mode: custombuilt Oct 19 19:09:25 volumio kernel: hdmitx: system: update rx hdr info 0 Oct 19 19:09:25 volumio kernel: hdmitx: system: update physcial size: 16 9 Oct 19 19:09:25 volumio kernel: hdmitx: video: already init VIC = 0 Now VIC = 116 Oct 19 19:09:25 volumio kernel: hdmitx: video: rx edid only support RGB format Oct 19 19:09:25 volumio kernel: hdmitx: hw: div40: 0 Oct 19 19:09:25 volumio kernel: hdmitx: ddc w1b error 0x54 0x20 0x00 Oct 19 19:09:25 volumio kernel: hdmitx: this mode doesn't have frac_rate Oct 19 19:09:25 volumio kernel: hdmitx: frac_rate = 1 Oct 19 19:09:25 volumio kernel: hdmitx: [hdmitx_set_clk_] vic == HDMI_CUSTOMBUILT, frac_freq 241500 Oct 19 19:09:25 volumio kernel: hdmitx: hpll_clk_out 4830000, od1 2, od2 1, od3 2 Oct 19 19:09:25 volumio kernel: hdmitx: config HPLL = 4830000 frac_rate = 0 Oct 19 19:09:25 volumio kernel: hdmitx: NO HPLL candidate - clk: 4830000, calculate HPLL Oct 19 19:09:25 volumio kernel: hdmitx: m1 0x0, m2 0x0, m 0xc9 Oct 19 19:09:25 volumio kernel: hdmitx: m 0xc9, frac 0x8000 Oct 19 19:09:25 volumio kernel: hdmitx: HPLL: 0xdb0004c9 Oct 19 19:09:25 volumio kernel: hdmitx: [set_g12a_hpll_clk_out] HPLL set OK! Oct 19 19:09:25 volumio kernel: hdmitx: config HPLL done Oct 19 19:09:25 volumio kernel: hdmitx: set_hpll_od3_clk_div[643] div = 6 Oct 19 19:09:25 volumio kernel: hdmitx: j = 15 vid_clk_div = 1 Oct 19 19:09:25 volumio kernel: hdmitx: system: irq 80000001 0 Oct 19 19:09:25 volumio kernel: hdmitx: hw: config hdmitx IP vic = 116 cd:4 cs: 0 Oct 19 19:09:25 volumio kernel: hdmitx: video: Sink is HDMI device Oct 19 19:09:25 volumio kernel: hdmitx: hw: set audio Oct 19 19:09:25 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Oct 19 19:09:25 volumio kernel: hdmitx: fs = 0, cd = 4, tmds_clk = 241500 Oct 19 19:09:25 volumio kernel: hdmitx: hw: aud_n_para = 6144 Oct 19 19:09:25 volumio kernel: hdmitx: hw: set channel status Oct 19 19:09:25 volumio kernel: vout: init mode custombuilt set ok Oct 19 19:09:25 volumio kernel: vout: aml_tvout_mode_monitor Oct 19 19:09:25 volumio kernel: vout: aml_vout_probe OK Oct 19 19:09:25 volumio kernel: chip type:0x2b Oct 19 19:09:25 volumio kernel: MEMORY:[0+ed800000] Oct 19 19:09:25 volumio kernel: ramdump_probe, storage device:data Oct 19 19:09:25 volumio kernel: NO valid ramdump args:0 0 Oct 19 19:09:25 volumio kernel: ramdump_probe, set sticky to 8ed8 Oct 19 19:09:25 volumio kernel: Advanced Linux Sound Architecture Driver Initialized. Oct 19 19:09:25 volumio kernel: NetLabel: Initializing Oct 19 19:09:25 volumio kernel: NetLabel: domain hash size = 128 Oct 19 19:09:25 volumio kernel: NetLabel: protocols = UNLABELED CIPSOv4 Oct 19 19:09:25 volumio kernel: NetLabel: unlabeled traffic allowed by default Oct 19 19:09:25 volumio kernel: clocksource: Switched to clocksource arch_sys_counter Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000104]: 0x00000001 Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000180]: 0x000000ff Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000181]: 0x000000ff Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000182]: 0x00000003 Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000183]: 0x00000007 Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000184]: 0x0000003f Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000185]: 0x00000002 Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000187]: 0x000000ff Oct 19 19:09:25 volumio kernel: hdmitx: [0x10000188]: 0x00000003 Oct 19 19:09:25 volumio kernel: VFS: Disk quotas dquot_6.6.0 Oct 19 19:09:25 volumio kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 19 19:09:25 volumio kernel: NET: Registered protocol family 2 Oct 19 19:09:25 volumio kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes) Oct 19 19:09:25 volumio kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes) Oct 19 19:09:25 volumio kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 19 19:09:25 volumio kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes) Oct 19 19:09:25 volumio kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes) Oct 19 19:09:25 volumio kernel: NET: Registered protocol family 1 Oct 19 19:09:25 volumio kernel: PCI: CLS 0 bytes, default 64 Oct 19 19:09:25 volumio kernel: Unpacking initramfs... Oct 19 19:09:25 volumio kernel: hdmitx: system: plugin Oct 19 19:09:25 volumio kernel: Freeing initrd memory: 12956K Oct 19 19:09:25 volumio kernel: hdmitx: edid: EDID Parser: Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: [RX]-up_phy_addr = 1 Oct 19 19:09:25 volumio kernel: hdmitx: edid: dump_dtd_info[2024] Oct 19 19:09:25 volumio kernel: hdmitx: edid: pixel_clock: 29600 Oct 19 19:09:25 volumio kernel: hdmitx: edid: h_active: 2560 Oct 19 19:09:25 volumio kernel: hdmitx: edid: h_blank: 106 Oct 19 19:09:25 volumio kernel: hdmitx: edid: v_active: 1440 Oct 19 19:09:25 volumio kernel: hdmitx: edid: v_blank: 41 Oct 19 19:09:25 volumio kernel: hdmitx: edid: h_sync_offset: 8 Oct 19 19:09:25 volumio kernel: hdmitx: edid: h_sync: 32 Oct 19 19:09:25 volumio kernel: hdmitx: edid: v_sync_offset: 3 Oct 19 19:09:25 volumio kernel: hdmitx: edid: v_sync: 5 Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Oct 19 19:09:25 volumio kernel: hdmitx: edid: find IEEEOUT Oct 19 19:09:25 volumio kernel: hdmitx: edid: check sum valid Oct 19 19:09:25 volumio kernel: hdmitx: edid: check sum valid Oct 19 19:09:25 volumio kernel: hdmitx: edid: update rx hdr info 0 at edid parsing Oct 19 19:09:25 volumio kernel: hdmitx: edid: check sum valid Oct 19 19:09:25 volumio kernel: hdmitx: edid: check sum valid Oct 19 19:09:25 volumio kernel: hdmitx: edid: blk0 raw data Oct 19 19:09:25 volumio kernel: hdmitx: edid: 00ffffffffffff00410c3ac237040000101f0103803c22782ad6e5ac524ea025 0e5054bfef00d1c0b30095008180814081c001010101565e00a0a0a029503020 350055502100001e000000ff0055484232313136303031303739000000fc0050 484c203237354532460a2020000000fd00304b1e721e000a20202020202001de Oct 19 19:09:25 volumio kernel: hdmitx: edid: blk1 raw data Oct 19 19:09:25 volumio kernel: hdmitx: edid: 020329f14b101f051404130312021101230907078301000067030c001000003c 681a00000101304be6a073006aa0a029500820350055502100001a2a4480a070 3827403020350055502100001a023a801871382d40582c450055502100001ef0 3c00d051a0355060883a0055502100001c000000000000000000000000000027 Oct 19 19:09:25 volumio kernel: hdmitx: system: update physcial size: 600 340 Oct 19 19:09:25 volumio kernel: hdmitx: video: Sink is HDMI device Oct 19 19:09:25 volumio kernel: hdmitx: hw: set audio Oct 19 19:09:25 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Oct 19 19:09:25 volumio kernel: hdmitx: fs = 0, cd = 4, tmds_clk = 241500 Oct 19 19:09:25 volumio kernel: hdmitx: hw: aud_n_para = 6144 Oct 19 19:09:25 volumio kernel: hdmitx: hw: set channel status Oct 19 19:09:25 volumio kernel: hdmitx: system: get current mode: custombuilt Oct 19 19:09:25 volumio kernel: hdmitx: system: update rx hdr info 0 Oct 19 19:09:25 volumio kernel: hdmitx: system: update physcial size: 600 340 Oct 19 19:09:25 volumio kernel: hdmitx: system: [set_disp_mode_auto] ALREADY init VIC = 116 Oct 19 19:09:25 volumio kernel: hdmitx: system: change to HDMI mode Oct 19 19:09:25 volumio kernel: hw perfevents: clusterb_enabled = 0 Oct 19 19:09:25 volumio kernel: hw perfevents: cpumasks 0xf, 0x0 Oct 19 19:09:25 volumio kernel: hw perfevents: cluster A irq = 18 Oct 19 19:09:25 volumio kernel: hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available Oct 19 19:09:25 volumio kernel: audit: initializing netlink subsys (disabled) Oct 19 19:09:25 volumio kernel: audit: type=2000 audit(1.064:1): initialized Oct 19 19:09:25 volumio kernel: workingset: timestamp_bits=46 max_order=20 bucket_order=0 Oct 19 19:09:25 volumio kernel: Registering sdcardfs 0.1 Oct 19 19:09:25 volumio kernel: SELinux: Registering netfilter hooks Oct 19 19:09:25 volumio kernel: NET: Registered protocol family 38 Oct 19 19:09:25 volumio kernel: Key type asymmetric registered Oct 19 19:09:25 volumio kernel: Asymmetric key parser 'x509' registered Oct 19 19:09:25 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) Oct 19 19:09:25 volumio kernel: io scheduler noop registered (default) Oct 19 19:09:25 volumio kernel: io scheduler deadline registered Oct 19 19:09:25 volumio kernel: io scheduler cfq registered Oct 19 19:09:25 volumio kernel: meson-pwm ff802000.pwm: pwm pinmux : can't get pinctrl Oct 19 19:09:25 volumio kernel: random: fast init done Oct 19 19:09:25 volumio kernel: random: crng init done Oct 19 19:09:25 volumio kernel: gpiomem-aml ff634000.gpiomem: Initialised: GPIO register area is 2 Oct 19 19:09:25 volumio kernel: gpiomem-aml ff634000.gpiomem: Initialised: Registers at start:0xff634000 end:0xff634fff size:0x00000fff Oct 19 19:09:25 volumio kernel: gpiomem-aml ff634000.gpiomem: Initialised: Registers at start:0xff800000 end:0xff800fff size:0x00000fff Oct 19 19:09:25 volumio kernel: [drm] Initialized Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: Continuing without Mali regulator control Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: max pp is 2 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: set min pp to default 1 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: min pp is 1 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: min clk is 4 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: hiu io source 0xffffff80084d9000 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: hiu io source 0xffffff80084db000 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: num of pp used most of time 1 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: clock dvfs cfg table size is 6 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: max clk set 4 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: max clk is 4 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: turbo clk set to 5 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: turbo clk is 5 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: default clk set to 4 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: default clk is 4 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: ====================0==================== clk_freq= 285714285, clk_parent=fclk_div7, voltage=1150, keep_count=5, threshod=<100 190>, clk_sample=285 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: ====================1==================== clk_freq= 400000000, clk_parent=fclk_div5, voltage=1150, keep_count=5, threshod=<152 207>, clk_sample=400 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: ====================2==================== clk_freq= 500000000, clk_parent=fclk_div4, voltage=1150, keep_count=5, threshod=<180 220>, clk_sample=500 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: ====================3==================== clk_freq= 666666666, clk_parent=fclk_div3, voltage=1150, keep_count=5, threshod=<210 236>, clk_sample=666 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: ====================4==================== clk_freq= 846000000, clk_parent= gp0_pll, voltage=1150, keep_count=5, threshod=<230 255>, clk_sample=846 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: ====================5==================== clk_freq= 846000000, clk_parent= gp0_pll, voltage=1150, keep_count=5, threshod=<230 255>, clk_sample=846 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: clock dvfs table size is 6 Oct 19 19:09:25 volumio kernel: mali_plat=ffffff800a6b8250 Oct 19 19:09:25 volumio kernel: meson_gcooldev is null, no set min status Oct 19 19:09:25 volumio kernel: gpu cooling register okay with err=0 Oct 19 19:09:25 volumio kernel: meson_gcooldev is null, no set min status Oct 19 19:09:25 volumio kernel: gpu core cooling register okay with err=0 Oct 19 19:09:25 volumio kernel: shader_present=1, tiler_present=1, l2_present=1 Oct 19 19:09:25 volumio kernel: Mali_pwr_on:gpu_irq : 200 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: GPU identified as 0x3 arch 7.0.9 r0p0 status 0 Oct 19 19:09:25 volumio kernel: mali ffe40000.bifrost: Probed as mali0 Oct 19 19:09:25 volumio kernel: Unable to detect cache hierarchy for CPU 0 Oct 19 19:09:25 volumio kernel: loop: module loaded Oct 19 19:09:25 volumio kernel: mtdoops: mtd device (mtddev=name/number) must be supplied Oct 19 19:09:25 volumio kernel: libphy: Fixed MDIO Bus: probed Oct 19 19:09:25 volumio kernel: REG0:Addr = ffffff80084f1540 Oct 19 19:09:25 volumio kernel: ee eth reset:Addr = ffffff80084f3008 Oct 19 19:09:25 volumio kernel: read auto_cali_idx fail Oct 19 19:09:25 volumio kernel: Not set cali_val for REG1 Oct 19 19:09:25 volumio kernel: meson6-dwmac ff3f0000.ethernet: no reset control found Oct 19 19:09:25 volumio kernel: stmmac - user ID: 0x11, Synopsys ID: 0x37 Oct 19 19:09:25 volumio kernel: Ring mode enabled Oct 19 19:09:25 volumio kernel: DMA HW capability register supported Oct 19 19:09:25 volumio kernel: Normal descriptors Oct 19 19:09:25 volumio kernel: RX Checksum Offload Engine supported Oct 19 19:09:25 volumio kernel: COE Type 2 Oct 19 19:09:25 volumio kernel: TX Checksum insertion supported Oct 19 19:09:25 volumio kernel: Wake-Up On Lan supported Oct 19 19:09:25 volumio kernel: eth%d: device MAC address 00:1e:06:48:2e:58 Oct 19 19:09:25 volumio kernel: Enable RX Mitigation via HW Watchdog Timer Oct 19 19:09:25 volumio kernel: libphy: stmmac: probed Oct 19 19:09:25 volumio kernel: eth%d: PHY ID 001cc916 at 0 IRQ POLL (stmmac-0:00) active Oct 19 19:09:25 volumio kernel: eth%d: PHY ID 001cc916 at 7 IRQ POLL (stmmac-0:07) Oct 19 19:09:25 volumio kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Oct 19 19:09:25 volumio kernel: ehci-pci: EHCI PCI platform driver Oct 19 19:09:25 volumio kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver cdc_acm Oct 19 19:09:25 volumio kernel: cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver usb-storage Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver usbserial Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver usbserial_generic Oct 19 19:09:25 volumio kernel: usbserial: USB Serial support registered for generic Oct 19 19:09:25 volumio kernel: mousedev: PS/2 mouse device common for all mice Oct 19 19:09:25 volumio kernel: i2c /dev entries driver Oct 19 19:09:25 volumio kernel: lirc_helper: wakeupkey 0xffffffff, protocol 0x1 Oct 19 19:09:25 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Oct 19 19:09:25 volumio kernel: hidraw: raw HID events driver (C) Jiri Kosina Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver usbhid Oct 19 19:09:25 volumio kernel: usbhid: USB HID core driver Oct 19 19:09:25 volumio kernel: value of voltage_tolerance 0 Oct 19 19:09:25 volumio kernel: meson_cpufreq_init:don't find the node Oct 19 19:09:25 volumio kernel: value of gp1_clk_target 0 Oct 19 19:09:25 volumio kernel: dvfs [meson_cpufreq_init] - cluster 0 freq 2016000 Oct 19 19:09:25 volumio kernel: dvfs [meson_cpufreq_init] - cluster 0 freq 2100000 Oct 19 19:09:25 volumio kernel: cpu cpu0: meson_cpufreq_init: CPU 0 initialized Oct 19 19:09:25 volumio kernel: ff803000.serial: clock gate not found Oct 19 19:09:25 volumio kernel: meson_uart ff803000.serial: ==uart0 reg addr = ffffff80084f9000 Oct 19 19:09:25 volumio kernel: ff803000.serial: ttyS0 at MMIO 0xff803000 (irq = 26, base_baud = 1500000) is a meson_uart Oct 19 19:09:25 volumio kernel: meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 0 to 115200 Oct 19 19:09:25 volumio kernel: console [ttyS0] enabled Oct 19 19:09:25 volumio kernel: amlogic-new-usb2-v2 ffe09000.usb2phy: USB2 phy probe:phy_mem:0xffe09000, iomap phy_base:0xffffff80084fb000 Oct 19 19:09:25 volumio kernel: amlogic-new-usb3-v2 ffe09080.usb3phy: USB3 phy probe:phy_mem:0xffe09080, iomap phy_base:0xffffff8008629080 Oct 19 19:09:25 volumio kernel: aml_dma ff63e000.aml_dma: Aml dma Oct 19 19:09:25 volumio kernel: aml_aes_dma ff63e000.aml_dma:aml_aes: Aml AES_dma Oct 19 19:09:25 volumio kernel: aml_sha_dma ff63e000.aml_dma:aml_sha: Aml SHA1/SHA224/SHA256 dma Oct 19 19:09:25 volumio kernel: gpio-keypad: probe of ff800000.gpio_keypad failed with error -22 Oct 19 19:09:25 volumio kernel: efusekeynum: 1 Oct 19 19:09:25 volumio kernel: efusekeyname: uuid offset: 0 size: 32 Oct 19 19:09:25 volumio kernel: efuse efuse: probe OK! Oct 19 19:09:25 volumio kernel: ion_dev soc:ion_dev: assigned reserved memory node linux,ion-dev Oct 19 19:09:25 volumio kernel: ge2d: ge2d_init_module Oct 19 19:09:25 volumio kernel: ge2d: ge2d_dev major:236 Oct 19 19:09:25 volumio kernel: ge2d: clock source clk_ge2d_gate ffffffc0c9de92c0 Oct 19 19:09:25 volumio kernel: ge2d: clock clk_ge2d source ffffffc0c9de95c0 Oct 19 19:09:25 volumio kernel: ge2d: clock source clk_vapb_0 ffffffc0c9de9340 Oct 19 19:09:25 volumio kernel: ge2d: ge2d init clock is 500000000 HZ, VPU clock is 666666656 HZ Oct 19 19:09:25 volumio kernel: ge2d: ge2d clock is 499 MHZ Oct 19 19:09:25 volumio kernel: ge2d: find address resource Oct 19 19:09:25 volumio kernel: ge2d: map io source 0x00000000ff940000,size=65536 to 0xffffff8008690000 Oct 19 19:09:25 volumio kernel: ge2d: reserved mem init failed Oct 19 19:09:25 volumio kernel: ge2d: ge2d: pdev=ffffffc0ca1d4800, irq=41, clk=ffffffc0c9de92c0 Oct 19 19:09:25 volumio kernel: ge2d: ge2d start monitor Oct 19 19:09:25 volumio kernel: ge2d: ge2d workqueue monitor start Oct 19 19:09:25 volumio kernel: [tsync_pcr_init]init success. Oct 19 19:09:25 volumio kernel: amvideom vsync irq: 42 Oct 19 19:09:25 volumio kernel: create_ge2d_work_queue video task ok Oct 19 19:09:25 volumio kernel: fb: osd_init_module Oct 19 19:09:25 volumio kernel: fb: viu vsync irq: 42 Oct 19 19:09:25 volumio kernel: fb: viu2 vsync irq: 58 Oct 19 19:09:25 volumio kernel: 0x000000db:Y=db,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000dc:Y=dc,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000dd:Y=dd,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000de:Y=de,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000df:Y=df,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000e0:Y=e0,U=0,V=0 Oct 19 19:09:25 volumio kernel: fb: osd_rdma_init: rdma_table p=0xcf608000,op=0xcf608000 , v=0xffffff8008635000 Oct 19 19:09:25 volumio kernel: rdma_register, rdma_table_addr ffffff8008637000 rdma_table_addr_phy cf609000 reg_buf ffffffc0ca05b000 Oct 19 19:09:25 volumio kernel: rdma_register success, handle 2 table_size 4096 Oct 19 19:09:25 volumio kernel: fb: osd_rdma_init:osd rdma handle = 2. Oct 19 19:09:25 volumio kernel: fb: mem_size: 0x800000 Oct 19 19:09:25 volumio kernel: fb: mem_size: 0x4b80000 Oct 19 19:09:25 volumio kernel: fb: mem_size: 0x100000 Oct 19 19:09:25 volumio kernel: fb: mem_size: 0x100000 Oct 19 19:09:25 volumio kernel: fb: mem_size: 0x800000 Oct 19 19:09:25 volumio kernel: fb: failed to init reserved memory Oct 19 19:09:25 volumio kernel: fb: fb def : 2560 1440 2560 2880 32 Oct 19 19:09:25 volumio kernel: fb: init fbdev bpp is:32 Oct 19 19:09:25 volumio kernel: fb: malloc_osd_memory, cma:ffffff800a8a1b30 Oct 19 19:09:25 volumio kernel: fb: malloc_osd_memory, 1231, base:0x00000000cf400000, size:8388608 Oct 19 19:09:25 volumio kernel: fb: use ion buffer for fb memory, fb_index=0 Oct 19 19:09:25 volumio kernel: fb: OSD0 as afbcd mode,afbc_type=2 Oct 19 19:09:25 volumio kernel: Now can use cma, free:2328, wm:3835 Oct 19 19:09:25 volumio kernel: meson-fb meson-fb: create ion_client ffffffc01e4d6240, handle=ffffffc01e4d4200 Oct 19 19:09:25 volumio kernel: meson-fb meson-fb: ion memory(0): created fb at 0x00000000e5800000, size 75 MiB Oct 19 19:09:25 volumio kernel: fb: 0, phy: 0x00000000e5800000, vir:0xffffff800a94f000, size=77312K Oct 19 19:09:25 volumio kernel: fb: Frame buffer memory assigned at Oct 19 19:09:25 volumio kernel: fb: 0, phy: 0x00000000e5800000, vir:0xffffff800a94f000, size=77312K Oct 19 19:09:25 volumio kernel: fb: 0, phy: 0x00000000e5800000, vir:0xffffff800a94f000, size=77312K Oct 19 19:09:25 volumio kernel: fb: logo_index=0,fb_index=0 Oct 19 19:09:25 volumio kernel: fb: ---------------clear fb0 memory ffffff800a94f000 Oct 19 19:09:25 volumio kernel: fb: osd[0] canvas.idx =0x40 Oct 19 19:09:25 volumio kernel: fb: osd[0] canvas.addr=0xe5800000 Oct 19 19:09:25 volumio kernel: fb: osd[0] canvas.width=10240 Oct 19 19:09:25 volumio kernel: fb: osd[0] canvas.height=2880 Oct 19 19:09:25 volumio kernel: fb: osd[0] frame.width=2560 Oct 19 19:09:25 volumio kernel: fb: osd[0] frame.height=1440 Oct 19 19:09:25 volumio kernel: fb: osd[0] out_addr_id =0x1 Oct 19 19:09:25 volumio kernel: Console: switching to colour frame buffer device 320x90 Oct 19 19:09:25 volumio kernel: clear:dec00000, free:dec00000, tick:770925 us Oct 19 19:09:25 volumio kernel: fb: osd[0] enable: 1 (swapper/0) Oct 19 19:09:25 volumio kernel: fb: set osd0 reverse as NONE Oct 19 19:09:25 volumio kernel: fb: osd probe OK Oct 19 19:09:25 volumio kernel: hdmitx: hdcp: hdmitx_hdcp_init Oct 19 19:09:25 volumio kernel: vout: vout2: create vout2 attribute OK Oct 19 19:09:25 volumio kernel: vout: vout2: vout2_fops_create OK Oct 19 19:09:25 volumio kernel: vout: vout2: clktree_init Oct 19 19:09:25 volumio kernel: vout: vout2: register server: nulldisp_vout2_server Oct 19 19:09:25 volumio kernel: vout: vout2: init mode null set ok Oct 19 19:09:25 volumio kernel: vout: vout2: aml_vout2_probe OK Oct 19 19:09:25 volumio kernel: DI: di_module_init ok. Oct 19 19:09:25 volumio kernel: DI: di_probe: Oct 19 19:09:25 volumio kernel: DI: di_probe: major 510 Oct 19 19:09:25 volumio kernel: deinterlace deinterlace: assigned reserved memory node linux,di_cma Oct 19 19:09:25 volumio kernel: di:flag_cma=1 Oct 19 19:09:25 volumio kernel: DI: CMA size 0x2800000. Oct 19 19:09:25 volumio kernel: pre_irq:56 Oct 19 19:09:25 volumio kernel: post_irq:57 Oct 19 19:09:25 volumio kernel: DI: di_probe allocate rdma channel 0. Oct 19 19:09:25 volumio kernel: di_get_vpu_clkb: get clk vpu error. Oct 19 19:09:25 volumio kernel: DI: vpu clkb <334000000, 667000000> Oct 19 19:09:25 volumio kernel: get clkb rate:333333328 Oct 19 19:09:25 volumio kernel: DI:enable vpu clkb. Oct 19 19:09:25 volumio kernel: 0x000000e1:Y=e1,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000e2:Y=e2,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000e3:Y=e3,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f0:Y=f0,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f1:Y=f1,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f2:Y=f2,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f3:Y=f3,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f4:Y=f4,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f5:Y=f5,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f6:Y=f6,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f7:Y=f7,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f8:Y=f8,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000f9:Y=f9,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000fa:Y=fa,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000fb:Y=fb,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000fc:Y=fc,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000fd:Y=fd,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000fe:Y=fe,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x000000ff:Y=ff,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x0000003a:Y=3a,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x0000003b:Y=3b,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x0000003c:Y=3c,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x0000003d:Y=3d,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x0000003e:Y=3e,U=0,V=0 Oct 19 19:09:25 volumio kernel: 0x0000003f:Y=3f,U=0,V=0 Oct 19 19:09:25 volumio kernel: DI: support multi decoding 61~62~63. Oct 19 19:09:25 volumio kernel: DI: di_probe:Di use HRTIMER Oct 19 19:09:25 volumio kernel: DI: di_probe:ok Oct 19 19:09:25 volumio kernel: dim:dim_module_init Oct 19 19:09:25 volumio kernel: dim:dim_module_init finish Oct 19 19:09:25 volumio kernel: dil:dil_init. Oct 19 19:09:25 volumio kernel: dil:dil_init ok. Oct 19 19:09:25 volumio kernel: vdin_drv_init: major 509 Oct 19 19:09:25 volumio kernel: vdin_drv_init: vdin driver init done Oct 19 19:09:25 volumio kernel: [viuin..]viuin_init_module viuin module init Oct 19 19:09:25 volumio kernel: [viuin..]viuin_probe probe ok. Oct 19 19:09:25 volumio kernel: [RX]-hdmirx: hdmirx_init. Oct 19 19:09:25 volumio kernel: ESM HLD: Initializing... Oct 19 19:09:25 volumio kernel: amlvid:info: amlvideo_init called Oct 19 19:09:25 volumio kernel: amlvid:info: amlvideo_create_instance called Oct 19 19:09:25 volumio kernel: amlvid:info: v4l2_dev.name=:amlvideo-000 Oct 19 19:09:25 volumio kernel: amlvideo-000: V4L2 device registered as video10 Oct 19 19:09:25 volumio kernel: amlvid:info: amlvideo_create_instance called Oct 19 19:09:25 volumio kernel: amlvid:info: v4l2_dev.name=:amlvideo-001 Oct 19 19:09:25 volumio kernel: amlvideo-001: V4L2 device registered as video23 Oct 19 19:09:25 volumio kernel: PPMGRDRV: warn: ppmgr module init func called Oct 19 19:09:25 volumio kernel: PPMGRDRV: info: ppmgr_driver_probe called Oct 19 19:09:25 volumio kernel: Reserved memory: failed to init DMA memory pool at 0x00000000ed800000, size 0 MiB Oct 19 19:09:25 volumio kernel: PPMGRDRV: info: ppmgr_dev major:507 Oct 19 19:09:25 volumio kernel: ionvideo-000: V4L2 device registered as video13 Oct 19 19:09:25 volumio kernel: ionvideo-001: V4L2 device registered as video14 Oct 19 19:09:25 volumio kernel: ionvideo-002: V4L2 device registered as video15 Oct 19 19:09:25 volumio kernel: ionvideo-003: V4L2 device registered as video16 Oct 19 19:09:25 volumio kernel: ionvideo-004: V4L2 device registered as video17 Oct 19 19:09:25 volumio kernel: ionvideo-005: V4L2 device registered as video18 Oct 19 19:09:25 volumio kernel: ionvideo-006: V4L2 device registered as video19 Oct 19 19:09:25 volumio kernel: ionvideo-007: V4L2 device registered as video20 Oct 19 19:09:25 volumio kernel: ionvideo-008: V4L2 device registered as video21 Oct 19 19:09:25 volumio kernel: ionvid: info: Video Technology Magazine Ion Video Oct 19 19:09:25 volumio kernel: ionvid: info: Capture Board ver 1.0 successfully loaded Oct 19 19:09:25 volumio kernel: videosync_create_instance dev_s ffffffc0c9d9f400,dev_s->dev ffffffc01e498800 Oct 19 19:09:25 volumio kernel: videosync_create_instance reg videosync.0 Oct 19 19:09:25 volumio kernel: aml_vecm_init:module init Oct 19 19:09:25 volumio kernel: videosync_thread started Oct 19 19:09:25 volumio kernel: VECM probe start Oct 19 19:09:25 volumio kernel: Can't find detect_colorbar. Oct 19 19:09:25 volumio kernel: Can't find detect_face. Oct 19 19:09:25 volumio kernel: Can't find detect_corn. Oct 19 19:09:25 volumio kernel: Can't find wb_sel. Oct 19 19:09:25 volumio kernel: hdr:Can't find cfg_en_osd_100. Oct 19 19:09:25 volumio kernel: amlogic, vecm Oct 19 19:09:25 volumio kernel: vlock dt support: 1 Oct 19 19:09:25 volumio kernel: vlock dt new_fsm: 0 Oct 19 19:09:25 volumio kernel: vlock dt hwver: 0 Oct 19 19:09:25 volumio kernel: vlock dt phlock_en: 0 Oct 19 19:09:25 volumio kernel: Can't find vlock_en. Oct 19 19:09:25 volumio kernel: Can't find vlock_mode. Oct 19 19:09:25 volumio kernel: Can't find vlock_pll_m_limit. Oct 19 19:09:25 volumio kernel: Can't find vlock_line_limit. Oct 19 19:09:25 volumio kernel: param_config vlock_en:1 md=0x4 Oct 19 19:09:25 volumio kernel: vlock: maxLine 524,maxPixel 1715 Oct 19 19:09:25 volumio kernel: vlock_status_init vlock_en:1 Oct 19 19:09:25 volumio kernel: aml_vecm_probe: ok Oct 19 19:09:25 volumio kernel: amdolby_vision_init:module init Oct 19 19:09:25 volumio kernel: amdolby_vision probe start & ver: 20181220 Oct 19 19:09:25 volumio kernel: cpu_id=2 tvmode=0 Oct 19 19:09:25 volumio kernel: dolby_vision_init_receiver(dvel) Oct 19 19:09:25 volumio kernel: dolby_vision_init_receiver: dvel Oct 19 19:09:25 volumio kernel: amdolby_vision_probe: ok Oct 19 19:09:25 volumio kernel: dovi disable in uboot Oct 19 19:09:25 volumio kernel: meson-mmc: mmc driver version: 3.02, 2017-05-15: New Emmc Host Controller Oct 19 19:09:25 volumio kernel: meson-mmc: >>>>>>>>hostbase ffffff80086b7000, dmode Oct 19 19:09:25 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Oct 19 19:09:25 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000033c Oct 19 19:09:25 volumio kernel: hdmitx: hdmitx_set_drm_pkt: tf=1, cf=1, colormetry=0 Oct 19 19:09:25 volumio kernel: meson-mmc: meson_mmc_probe() : success! Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0x9dff0800,virqc:3fff Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: err: wait for desc write back, bus_fsm:0x7 Oct 19 19:09:25 volumio kernel: meson-mmc: meson_mmc_irq_thread_v3() 653: set 1st retry! Oct 19 19:09:25 volumio kernel: meson-mmc: retry cmd 1 the 3-th time(s) Oct 19 19:09:25 volumio kernel: meson-mmc: >>>>>>>>hostbase ffffff80086c0000, dmode Oct 19 19:09:25 volumio kernel: meson-mmc: gpio_cd = 1ca Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0xa1ff2800,virqc:3fff Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: err: wait for irq service, bus_fsm:0x8 Oct 19 19:09:25 volumio kernel: meson-mmc: retry cmd 1 the 2-th time(s) Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0x9dff0800,virqc:3fff Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: err: wait for desc write back, bus_fsm:0x7 Oct 19 19:09:25 volumio kernel: meson-mmc: retry cmd 1 the 1-th time(s) Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0x9dff0800,virqc:3fff Oct 19 19:09:25 volumio kernel: meson-mmc: emmc: err: wait for desc write back, bus_fsm:0x7 Oct 19 19:09:25 volumio kernel: meson-mmc: Command retried failed line:675, cmd:1 Oct 19 19:09:25 volumio kernel: meson-mmc: meson_mmc_probe() : success! Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: cec driver date:2019/10/22: finetune ARB rising time Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: compatible:amlogic, aocec-sm1 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: cecb_ver:0x2 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: line_reg:0x1 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: line_bit:0x3 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: ee_to_ao:0x1 Oct 19 19:09:25 volumio kernel: input: cec_input as /devices/virtual/input/input0 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: not find 'port_num' Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: using cec:1 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: no hdmirx regs Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: no hhi regs Oct 19 19:09:25 volumio kernel: irq cnt:2, a:40, b39 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: wakeup_reason:0x0 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: cev val1: 0x0;val2: 0x0 Oct 19 19:09:25 volumio kernel: cectx ff80023c.aocec: aml_cec_probe success end Oct 19 19:09:25 volumio kernel: unifykey: storage in base: 0xffffffc005000000 Oct 19 19:09:25 volumio kernel: unifykey: storage out base: 0xffffffc005040000 Oct 19 19:09:25 volumio kernel: unifykey: storage block base: 0xffffffc005080000 Oct 19 19:09:25 volumio kernel: unifykey: probe done! Oct 19 19:09:25 volumio kernel: unifykey: no efuse-version set, use default value: -1 Oct 19 19:09:25 volumio kernel: unifykey: key unify config unifykey-num is 14 Oct 19 19:09:25 volumio kernel: unifykey: key unify fact unifykey-num is 17 Oct 19 19:09:25 volumio kernel: unifykey: unifykey_devno: 1f600000 Oct 19 19:09:25 volumio kernel: unifykey: device unifykeys created ok Oct 19 19:09:25 volumio kernel: unifykey: aml_unifykeys_init done! Oct 19 19:09:25 volumio kernel: meson ts init Oct 19 19:09:25 volumio kernel: tsensor id: 0 Oct 19 19:09:25 volumio kernel: r1p1_tsensor_read valid cnt is 0 Oct 19 19:09:25 volumio kernel: tsensor trim info: 0xfa000017! Oct 19 19:09:25 volumio kernel: tsensor hireboot: 0xc0ff2a70 Oct 19 19:09:25 volumio kernel: meson ts init Oct 19 19:09:25 volumio kernel: tsensor id: 1 Oct 19 19:09:25 volumio kernel: r1p1_tsensor_read valid cnt is 0 Oct 19 19:09:25 volumio kernel: tsensor trim info: 0xfa000029! Oct 19 19:09:25 volumio kernel: tsensor hireboot: 0xc0ff2a70 Oct 19 19:09:25 volumio kernel: audio_dsp: [dsp]register dsp to char divece(257) Oct 19 19:09:25 volumio kernel: amaudio: amaudio: driver amaudio init! Oct 19 19:09:25 volumio kernel: amaudio: amaudio_init - amaudio: driver amaudio succuess! Oct 19 19:09:25 volumio kernel: amlkaraoke init success! Oct 19 19:09:25 volumio kernel: sysled: module init Oct 19 19:09:25 volumio kernel: meson_wdt ffd0f0d0.watchdog: start watchdog Oct 19 19:09:25 volumio kernel: meson_wdt ffd0f0d0.watchdog: creat work queue for watch dog Oct 19 19:09:25 volumio kernel: meson_wdt ffd0f0d0.watchdog: AML Watchdog Timer probed done Oct 19 19:09:25 volumio kernel: meson-saradc ff809000.saradc: set delay per tick to <1ms> by default. Oct 19 19:09:25 volumio kernel: meson-saradc ff809000.saradc: set ticks per period to <1> by default. Oct 19 19:09:25 volumio kernel: dmc_monitor_probe Oct 19 19:09:25 volumio kernel: atv_demod: aml_atvdemod_init: OK, atv demod version: V2.15. Oct 19 19:09:25 volumio kernel: defendkey ff630218.defendkey: Reserved memory is not enough! Oct 19 19:09:25 volumio kernel: defendkey: probe of ff630218.defendkey failed with error -22 Oct 19 19:09:25 volumio kernel: usbcore: registered new interface driver snd-usb-audio Oct 19 19:09:25 volumio kernel: Error: Driver 'spdif-dit' is already registered, aborting... Oct 19 19:09:25 volumio kernel: asoc debug: aml_audio_controller_probe-130 Oct 19 19:09:25 volumio kernel: aml_spdif_platform_probe, spdif ID = 0 Oct 19 19:09:25 volumio kernel: SPDIF id 0 asrc_id:0 auto_asrc:0 Oct 19 19:09:25 volumio kernel: spdifout_play_with_zerodata, spdif id:0 enable:0 Oct 19 19:09:25 volumio kernel: spdif_a fifo ctrl, frddr:0 type:3, 32 bits, chmask 0x3, swap 0x10 Oct 19 19:09:25 volumio kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Oct 19 19:09:25 volumio kernel: hdmitx: audio: aout notify format CT_PCM Oct 19 19:09:25 volumio kernel: hdmitx: hw: set audio Oct 19 19:09:25 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Oct 19 19:09:25 volumio kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 241500 Oct 19 19:09:25 volumio kernel: hdmitx: hw: aud_n_para = 6144 Oct 19 19:09:25 volumio kernel: hdmitx: hw: set channel status Oct 19 19:09:25 volumio kernel: hdmitx: audio: Audio Type: PCM Oct 19 19:09:25 volumio kernel: hdmitx: audio: set audio param Oct 19 19:09:25 volumio kernel: spdif_a is set to enable Oct 19 19:09:25 volumio kernel: aml_spdif_platform_probe, register soc platform Oct 19 19:09:25 volumio kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 0, irqs toddr 27, frddr 31 Oct 19 19:09:25 volumio kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 1, irqs toddr 28, frddr 32 Oct 19 19:09:25 volumio kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 2, irqs toddr 29, frddr 33 Oct 19 19:09:25 volumio kernel: audio-ddr-manager ff660000.audiobus:ddr_manager: 3, irqs toddr 30, frddr 34 Oct 19 19:09:25 volumio kernel: audiolocker_platform_probe Oct 19 19:09:25 volumio kernel: Register vad Oct 19 19:09:25 volumio kernel: aml_dai_spdif_probe Oct 19 19:09:25 volumio kernel: set normal 512 fs /4 fs Oct 19 19:09:25 volumio kernel: set spdifout clk:6144000, mpll:24576000 Oct 19 19:09:25 volumio kernel: get spdifout clk:6143997, mpll:24575987 Oct 19 19:09:25 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Oct 19 19:09:25 volumio kernel: aml_spdif_new spdif_a, clk continuous:1 Oct 19 19:09:25 volumio kernel: spdifout_play_with_zerodata_free, spdif id:0 Oct 19 19:09:25 volumio kernel: asoc-aml-card odroid_hdmi: dit-hifi <-> SPDIF mapping ok Oct 19 19:09:25 volumio kernel: snd_card_add_kcontrols card:ffffffc01e67f018 Oct 19 19:09:25 volumio kernel: effect_v2 is not init Oct 19 19:09:25 volumio kernel: Not init vad Oct 19 19:09:25 volumio kernel: Failed to add VAD controls Oct 19 19:09:25 volumio kernel: eq/drc v1 function enable Oct 19 19:09:25 volumio kernel: no node audio_effect for eq/drc info! Oct 19 19:09:25 volumio kernel: Failed to add audio effects v1 controls Oct 19 19:09:25 volumio kernel: Netfilter messages via NETLINK v0.30. Oct 19 19:09:25 volumio kernel: Initializing XFRM netlink socket Oct 19 19:09:25 volumio kernel: NET: Registered protocol family 17 Oct 19 19:09:25 volumio kernel: Key type dns_resolver registered Oct 19 19:09:25 volumio kernel: Registered swp emulation handler Oct 19 19:09:25 volumio kernel: Registered cp15_barrier emulation handler Oct 19 19:09:25 volumio kernel: Registered setend emulation handler Oct 19 19:09:25 volumio kernel: disable EAS feature Oct 19 19:09:25 volumio kernel: registered taskstats version 1 Oct 19 19:09:25 volumio kernel: dwc3 ff500000.dwc3: Configuration mismatch. dr_mode forced to host Oct 19 19:09:25 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Oct 19 19:09:25 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1 Oct 19 19:09:25 volumio kernel: xhci-hcd xhci-hcd.0.auto: hcc params 0x0228fe6c hci version 0x110 quirks 0x20010010 Oct 19 19:09:25 volumio kernel: xhci-hcd xhci-hcd.0.auto: irq 22, io mem 0xff500000 Oct 19 19:09:25 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Oct 19 19:09:25 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 19 19:09:25 volumio kernel: usb usb1: Product: xHCI Host Controller Oct 19 19:09:25 volumio kernel: usb usb1: Manufacturer: Linux 4.9.241+ xhci-hcd Oct 19 19:09:25 volumio kernel: usb usb1: SerialNumber: xhci-hcd.0.auto Oct 19 19:09:25 volumio kernel: hub 1-0:1.0: USB hub found Oct 19 19:09:25 volumio kernel: hub 1-0:1.0: 2 ports detected Oct 19 19:09:25 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Oct 19 19:09:25 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 Oct 19 19:09:25 volumio kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Oct 19 19:09:25 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 Oct 19 19:09:25 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Oct 19 19:09:25 volumio kernel: usb usb2: Product: xHCI Host Controller Oct 19 19:09:25 volumio kernel: usb usb2: Manufacturer: Linux 4.9.241+ xhci-hcd Oct 19 19:09:25 volumio kernel: usb usb2: SerialNumber: xhci-hcd.0.auto Oct 19 19:09:25 volumio kernel: hub 2-0:1.0: USB hub found Oct 19 19:09:25 volumio kernel: hub 2-0:1.0: 1 port detected Oct 19 19:09:25 volumio kernel: hctosys: unable to open rtc device (rtc0) Oct 19 19:09:25 volumio kernel: dwc_otg ff400000.dwc2_a: dwc_otg_driver_probe(ffffffc0ca150c00) Oct 19 19:09:25 volumio kernel: dwc_otg: usb0: type: 2 speed: 0, config: 0, dma: 0, id: 0, phy: ffe09000, ctrl: 0 Oct 19 19:09:25 volumio kernel: dwc_otg ff400000.dwc2_a: base=0xffffff8008b40000 Oct 19 19:09:25 volumio kernel: dwc_otg ff400000.dwc2_a: dwc_otg_device=0xffffffc01e5c7000 Oct 19 19:09:25 volumio kernel: dwc_otg: Core Release: 3.30a Oct 19 19:09:25 volumio kernel: dwc_otg: Setting default values for core params Oct 19 19:09:25 volumio kernel: dwc_otg: curmode: 0, host_only: 0 Oct 19 19:09:25 volumio kernel: dwc_otg ff400000.dwc2_a: DMA config: BURST_DEFAULT Oct 19 19:09:25 volumio kernel: dwc_otg: Using Buffer DMA mode Oct 19 19:09:25 volumio kernel: dwc_otg: OTG VER PARAM: 1, OTG VER FLAG: 1 Oct 19 19:09:25 volumio kernel: dwc_otg: Working on port type = SLAVE Oct 19 19:09:25 volumio kernel: dwc_otg: Dedicated Tx FIFOs mode Oct 19 19:09:25 volumio kernel: meson_cdev probe Oct 19 19:09:25 volumio kernel: thermal: read gpupp failed Oct 19 19:09:25 volumio kernel: meson_cdev index: 0 Oct 19 19:09:25 volumio kernel: thermal: read gpupp failed Oct 19 19:09:25 volumio kernel: meson_cdev index: 1 Oct 19 19:09:25 volumio kernel: cpucore_cooling_register, max_cpu_core_num:4 Oct 19 19:09:25 volumio kernel: meson_cdev index: 2 Oct 19 19:09:25 volumio kernel: thermal: read gpupp failed Oct 19 19:09:25 volumio kernel: meson_cdev index: 3 Oct 19 19:09:25 volumio kernel: find tzd id: 0 Oct 19 19:09:25 volumio kernel: find tzd id: 0 Oct 19 19:09:25 volumio kernel: meson_cdev probe done Oct 19 19:09:25 volumio kernel: gxbb_pm: enter meson_pm_probe! Oct 19 19:09:25 volumio kernel: no vddio3v3_en pin Oct 19 19:09:25 volumio kernel: pm-meson aml_pm: Can't get switch_clk81 Oct 19 19:09:25 volumio kernel: gxbb_pm: meson_pm_probe done Oct 19 19:09:25 volumio kernel: ALSA device list: Oct 19 19:09:25 volumio kernel: #0: ODROID-HDMI Oct 19 19:09:25 volumio kernel: meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 115200 to 115200 Oct 19 19:09:25 volumio kernel: Freeing unused kernel memory: 4992K Oct 19 19:09:25 volumio kernel: meson-mmc: card IN Oct 19 19:09:25 volumio kernel: meson-mmc: normal card in Oct 19 19:09:25 volumio kernel: usb 1-1: new high-speed USB device number 2 using xhci-hcd Oct 19 19:09:25 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Oct 19 19:09:25 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000033c Oct 19 19:09:25 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Oct 19 19:09:25 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000033c Oct 19 19:09:25 volumio kernel: meson-aml-mmc ffe05000.sd: divider requested rate 200000000 != actual rate 199999997: ret=0 Oct 19 19:09:25 volumio kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80 Oct 19 19:09:25 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245 Oct 19 19:09:25 volumio kernel: meson-mmc: Data 1 aligned delay is 0 Oct 19 19:09:25 volumio kernel: meson-mmc: sd: clk 199999997 tuning start Oct 19 19:09:25 volumio kernel: meson-mmc: sd: adj_win: < 0 1 2 3 > Oct 19 19:09:25 volumio kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104 Oct 19 19:09:25 volumio kernel: meson-mmc: sd: adj_win: < 0 1 2 3 > Oct 19 19:09:25 volumio kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208 Oct 19 19:09:25 volumio kernel: meson-mmc: sd: adj_win: < 0 1 2 3 4 > Oct 19 19:09:25 volumio kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c Oct 19 19:09:25 volumio kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=2817 Oct 19 19:09:25 volumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Oct 19 19:09:25 volumio kernel: usb 1-1: Product: USB2.0 Hub Oct 19 19:09:25 volumio kernel: usb 1-1: Manufacturer: VIA Labs, Inc. Oct 19 19:09:25 volumio kernel: meson-mmc: sd: adj_win: < 0 1 2 3 > Oct 19 19:09:25 volumio kernel: meson-mmc: step:16, delay1:0x10410410, delay2:0x10010410 Oct 19 19:09:25 volumio kernel: hub 1-1:1.0: USB hub found Oct 19 19:09:25 volumio kernel: hub 1-1:1.0: 4 ports detected Oct 19 19:09:25 volumio kernel: meson-mmc: sd: adj_win: < 1 2 3 4 > Oct 19 19:09:25 volumio kernel: meson-mmc: left:3, right:0, mid:4, size:4 Oct 19 19:09:25 volumio kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0 Oct 19 19:09:25 volumio kernel: meson-mmc: sd: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x22000 Oct 19 19:09:25 volumio kernel: meson-mmc: delay1:0x0, delay2:0x0 Oct 19 19:09:25 volumio kernel: sd: new ultra high speed SDR104 SDHC card at address aaaa Oct 19 19:09:25 volumio kernel: sd: clock 199999997, 4-bit-bus-width Oct 19 19:09:25 volumio kernel: mmcblk1: sd:aaaa SC16G 14.8 GiB Oct 19 19:09:25 volumio kernel: mmcblk1: p1 p2 p3 Oct 19 19:09:25 volumio kernel: usb 2-1: new SuperSpeed USB device number 2 using xhci-hcd Oct 19 19:09:25 volumio kernel: usb 2-1: New USB device found, idVendor=2109, idProduct=0817 Oct 19 19:09:25 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Oct 19 19:09:25 volumio kernel: usb 2-1: Product: USB3.0 Hub Oct 19 19:09:25 volumio kernel: usb 2-1: Manufacturer: VIA Labs, Inc. Oct 19 19:09:25 volumio kernel: hub 2-1:1.0: USB hub found Oct 19 19:09:25 volumio kernel: hub 2-1:1.0: 4 ports detected Oct 19 19:09:25 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 19 19:09:25 volumio kernel: usb 1-1.1: new low-speed USB device number 3 using xhci-hcd Oct 19 19:09:25 volumio kernel: usb 1-1.1: New USB device found, idVendor=04d9, idProduct=1603 Oct 19 19:09:25 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Oct 19 19:09:25 volumio kernel: usb 1-1.1: Product: USB Keyboard Oct 19 19:09:25 volumio kernel: usb 1-1.1: Manufacturer: Oct 19 19:09:25 volumio kernel: input: USB Keyboard as /devices/platform/ff500000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1.1/1-1.1:1.0/0003:04D9:1603.0001/input/input1 Oct 19 19:09:25 volumio kernel: hid-generic 0003:04D9:1603.0001: input,hidraw0: USB HID v1.10 Keyboard [ USB Keyboard] on usb-xhci-hcd.0.auto-1.1/input0 Oct 19 19:09:25 volumio kernel: input: USB Keyboard as /devices/platform/ff500000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1.1/1-1.1:1.1/0003:04D9:1603.0002/input/input2 Oct 19 19:09:25 volumio kernel: hid-generic 0003:04D9:1603.0002: input,hidraw1: USB HID v1.10 Device [ USB Keyboard] on usb-xhci-hcd.0.auto-1.1/input1 Oct 19 19:09:25 volumio kernel: EXT4-fs (mmcblk1p2): recovery complete Oct 19 19:09:25 volumio kernel: EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) Oct 19 19:09:25 volumio kernel: EXT4-fs (mmcblk1p3): recovery complete Oct 19 19:09:25 volumio kernel: EXT4-fs (mmcblk1p3): mounted filesystem with ordered data mode. Opts: (null) Oct 19 19:09:25 volumio systemd[1]: System time before build time, advancing clock. Oct 19 19:09:25 volumio kernel: NET: Registered protocol family 10 Oct 19 19:09:25 volumio kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Oct 19 19:09:25 volumio kernel: cgroup: cgroup2: unknown option "nsdelegate" Oct 19 19:09:25 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) Oct 19 19:09:25 volumio systemd[1]: Detected architecture arm64. Oct 19 19:09:25 volumio systemd[1]: Set hostname to . Oct 19 19:09:25 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. Oct 19 19:09:25 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Oct 19 19:09:25 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. Oct 19 19:09:25 volumio systemd[1]: Listening on Journal Socket. Oct 19 19:09:25 volumio systemd[1]: Starting Load Kernel Modules... Oct 19 19:09:25 volumio systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. Oct 19 19:09:25 volumio systemd[1]: Mounting RPC Pipe File System... Oct 19 19:09:25 volumio kernel: Removed cp15_barrier emulation handler Oct 19 19:09:25 volumio kernel: Enabled cp15_barrier support Oct 19 19:09:25 volumio kernel: RPC: Registered named UNIX socket transport module. Oct 19 19:09:25 volumio kernel: RPC: Registered udp transport module. Oct 19 19:09:25 volumio kernel: RPC: Registered tcp transport module. Oct 19 19:09:25 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 19 19:09:25 volumio systemd-journald[2075]: Journal started Oct 19 19:09:25 volumio systemd-journald[2075]: Runtime journal (/run/log/journal/af8878b85456c7d2e9b1aa7a6664d164) is 3.7M, max 30.0M, 26.2M free. Oct 19 19:09:25 volumio fake-hwclock[2068]: Sat Oct 19 16:09:25 UTC 2024 Oct 19 19:09:25 volumio systemd[1]: Started Load/Save Random Seed. Oct 19 19:09:25 volumio systemd[1]: Started Create System Users. Oct 19 19:09:25 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Oct 19 19:09:25 volumio systemd[1]: Started Create Static Device Nodes in /dev. Oct 19 19:09:25 volumio systemd[1]: Reached target Local File Systems (Pre). Oct 19 19:09:25 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Oct 19 19:09:25 volumio systemd[1]: Mounting /var/log... Oct 19 19:09:25 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Oct 19 19:09:25 volumio systemd[1]: Mounting /tmp... Oct 19 19:09:25 volumio systemd[1]: Mounting /var/spool/cups... Oct 19 19:09:25 volumio systemd[1]: Starting udev Kernel Device Manager... Oct 19 19:09:25 volumio systemd[1]: Mounted /var/log. Oct 19 19:09:25 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Oct 19 19:09:25 volumio systemd[1]: Mounted /tmp. Oct 19 19:09:25 volumio systemd[1]: Mounted /var/spool/cups. Oct 19 19:09:25 volumio systemd[1]: Mounting /var/spool/cups/tmp... Oct 19 19:09:25 volumio systemd-udevd[2099]: Network interface NamePolicy= disabled on kernel command line, ignoring. Oct 19 19:09:25 volumio systemd-journald[2075]: Runtime journal (/run/log/journal/af8878b85456c7d2e9b1aa7a6664d164) is 3.7M, max 30.0M, 26.2M free. Oct 19 19:09:25 volumio systemd[1]: Started Flush Journal to Persistent Storage. Oct 19 19:09:25 volumio systemd[1]: Started udev Coldplug all Devices. Oct 19 19:09:25 volumio systemd[1]: Mounted /var/spool/cups/tmp. Oct 19 19:09:25 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Oct 19 19:09:25 volumio systemd[1]: Started udev Kernel Device Manager. Oct 19 19:09:25 volumio systemd[1]: Starting Show Plymouth Boot Screen... Oct 19 19:09:25 volumio systemd[1]: plymouth-start.service: Succeeded. Oct 19 19:09:25 volumio systemd[1]: Started Show Plymouth Boot Screen. Oct 19 19:09:25 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Oct 19 19:09:25 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Oct 19 19:09:25 volumio systemd[1]: Reached target Paths. Oct 19 19:09:25 volumio systemd[1]: Reached target Local Encrypted Volumes. Oct 19 19:09:25 volumio systemd-udevd[2117]: Using default interface naming scheme 'v240'. Oct 19 19:09:25 volumio kernel: register clk_set_setting cpu[43] Oct 19 19:09:25 volumio kernel: Registered firmware driver success. Oct 19 19:09:25 volumio kernel: Try to load video/h264_enc.bin ... Oct 19 19:09:25 volumio systemd-udevd[2117]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 19 19:09:25 volumio systemd-udevd[2117]: link_config: could not get ethtool features for eth0 Oct 19 19:09:25 volumio systemd-udevd[2117]: Could not set offload features of eth0: Device or resource busy Oct 19 19:09:25 volumio kernel: load firmware size : 76288, Name : video/h264_enc.bin. Oct 19 19:09:25 volumio kernel: Try to load video/video_ucode.bin ... Oct 19 19:09:25 volumio systemd-udevd[2108]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 19 19:09:25 volumio kernel: load firmware size : 1816576, Name : video/video_ucode.bin. Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: ionvid: dbg: ionvideo open Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close!!!! Oct 19 19:09:25 volumio kernel: ionvid: dbg: vidioc_close Oct 19 19:09:25 volumio kernel: Amlogic A/V streaming port init Oct 19 19:09:25 volumio kernel: get gate demux control ok ffffffc0c7625c40 Oct 19 19:09:25 volumio kernel: get gate parser_top control ok ffffffc0c7625cc0 Oct 19 19:09:25 volumio kernel: get gate vdec control ok ffffffc0c7625d40 Oct 19 19:09:25 volumio kernel: get gate clk_81 control ok ffffffc0c7625dc0 Oct 19 19:09:25 volumio kernel: get gate clk_vdec_mux control ok ffffffc0c7625ec0 Oct 19 19:09:25 volumio kernel: get gate clk_hcodec_mux control ok ffffffc0c7625f40 Oct 19 19:09:25 volumio kernel: get gate clk_hevc_mux control ok ffffffc0c7625fc0 Oct 19 19:09:25 volumio kernel: get gate clk_hevcb_mux control ok ffffffc0c75de040 Oct 19 19:09:25 volumio kernel: get gate ahbarb0 control ok ffffffc0c75de0c0 Oct 19 19:09:25 volumio kernel: get gate asyncfifo control failed (null) Oct 19 19:09:25 volumio systemd-udevd[2130]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 19 19:09:25 volumio kernel: decoder registered as /dev/video26 Oct 19 19:09:25 volumio systemd-udevd[2108]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 19 19:09:25 volumio kernel: [0] vcodec_dec decoder Oct 19 19:09:25 volumio kernel: [0] release decoder Oct 19 19:09:25 volumio systemd-udevd[2114]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 19 19:09:25 volumio systemd[1]: Found device /dev/ttyS0. Oct 19 19:09:25 volumio kernel: out of value, fixed it Oct 19 19:09:25 volumio kernel: id=0 set inskew=0 Oct 19 19:09:25 volumio systemd[1]: Found device /dev/disk/by-uuid/1E7D-6AB2. Oct 19 19:09:25 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Oct 19 19:09:25 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/1E7D-6AB2... Oct 19 19:09:25 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 19 19:09:25 volumio systemd[1]: Condition check resulted in FUSE Control File System being skipped. Oct 19 19:09:25 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 19 19:09:25 volumio systemd[1]: Condition check resulted in Huge Pages File System being skipped. Oct 19 19:09:25 volumio systemd[1]: Starting Show Plymouth Boot Screen... Oct 19 19:09:25 volumio systemd[1]: Started File System Check Daemon to report status. Oct 19 19:09:25 volumio systemd[1]: plymouth-start.service: Succeeded. Oct 19 19:09:26 volumio systemd[1]: Started Show Plymouth Boot Screen. Oct 19 19:09:26 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Oct 19 19:09:26 volumio kernel: vout: aml_tvout_mode_work: monitor_timeout Oct 19 19:09:26 volumio systemd[1]: Found device /sys/subsystem/net/devices/eth0. Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Oct 19 19:09:26 volumio systemd-fsck[2196]: fsck.fat 4.1 (2017-01-24) Oct 19 19:09:26 volumio systemd-fsck[2196]: /dev/mmcblk1p1: 46 files, 43857/120958 clusters Oct 19 19:09:26 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/1E7D-6AB2. Oct 19 19:09:26 volumio systemd[1]: Mounting /boot... Oct 19 19:09:26 volumio systemd[1]: Mounted /boot. Oct 19 19:09:26 volumio systemd[1]: Reached target Local File Systems. Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 19 19:09:26 volumio systemd[1]: Started ifup for eth0. Oct 19 19:09:26 volumio systemd[1]: Starting Preprocess NFS configuration... Oct 19 19:09:26 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Oct 19 19:09:26 volumio systemd[1]: Starting Raise network interfaces... Oct 19 19:09:26 volumio systemd[1]: Starting Create Volatile Files and Directories... Oct 19 19:09:26 volumio systemd[1]: Received SIGRTMIN+20 from PID 1968 (plymouthd). Oct 19 19:09:26 volumio systemd[1]: plymouth-read-write.service: Succeeded. Oct 19 19:09:26 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Oct 19 19:09:26 volumio systemd[1]: nfs-config.service: Succeeded. Oct 19 19:09:26 volumio systemd[1]: Started Preprocess NFS configuration. Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Oct 19 19:09:26 volumio systemd[1]: Reached target NFS client services. Oct 19 19:09:26 volumio ifup[2211]: command failed: No such device (-19) Oct 19 19:09:26 volumio sh[2207]: command failed: No such device (-19) Oct 19 19:09:26 volumio systemd[1]: Started Create Volatile Files and Directories. Oct 19 19:09:26 volumio systemd[1]: Starting RPC bind portmap service... Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Oct 19 19:09:26 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Oct 19 19:09:26 volumio ifup[2211]: command failed: No such device (-19) Oct 19 19:09:26 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Oct 19 19:09:26 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Oct 19 19:09:26 volumio systemd[1]: Reached target System Initialization. Oct 19 19:09:26 volumio systemd[1]: Started Daily apt download activities. Oct 19 19:09:26 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 19 19:09:26 volumio systemd[1]: Listening on lircd.socket. Oct 19 19:09:26 volumio systemd[1]: Listening on triggerhappy.socket. Oct 19 19:09:26 volumio systemd[1]: Started Daily apt upgrade and clean activities. Oct 19 19:09:26 volumio systemd[1]: Reached target Timers. Oct 19 19:09:26 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 19 19:09:26 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Oct 19 19:09:26 volumio systemd[1]: Reached target Sockets. Oct 19 19:09:26 volumio systemd[1]: Reached target Basic System. Oct 19 19:09:26 volumio systemd[1]: Started Volumio Log Rotation Service. Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Oct 19 19:09:26 volumio kernel: meson6-dwmac ff3f0000.ethernet eth0: fail to init PTP. Oct 19 19:09:26 volumio systemd[1]: Started volumio-remote-updater.service. Oct 19 19:09:26 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Oct 19 19:09:26 volumio systemd[1]: Started D-Bus System Message Bus. Oct 19 19:09:26 volumio thd[2275]: Unable to parse trigger line: Oct 19 19:09:26 volumio thd[2275]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Oct 19 19:09:26 volumio thd[2275]: Unable to parse trigger line: Oct 19 19:09:26 volumio thd[2275]: Unable to parse trigger line: Oct 19 19:09:26 volumio thd[2275]: Found socket passed from systemd Oct 19 19:09:26 volumio systemd[1]: Starting WPA supplicant... Oct 19 19:09:26 volumio systemd[1]: Started Volumio Iptables Module. Oct 19 19:09:26 volumio systemd[1]: Starting Login Service... Oct 19 19:09:26 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Oct 19 19:09:26 volumio systemd[1]: Starting DHCP Client Daemon... Oct 19 19:09:26 volumio systemd[1]: Starting lircd(8) initialization helper tool... Oct 19 19:09:26 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 19 19:09:26 volumio systemd[1]: Starting Wireless Services... Oct 19 19:09:26 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Oct 19 19:09:26 volumio systemd[1]: Started Manage Sound Card State (restore and store). Oct 19 19:09:26 volumio systemd[1]: Starting Save/Restore Sound Card State... Oct 19 19:09:26 volumio systemd[1]: Started RPC bind portmap service. Oct 19 19:09:26 volumio systemd[1]: Started triggerhappy global hotkey daemon. Oct 19 19:09:26 volumio alsactl[2300]: alsactl 1.1.8 daemon started Oct 19 19:09:26 volumio systemd[1]: Reached target RPC Port Mapper. Oct 19 19:09:26 volumio systemd[1]: Reached target Remote File Systems (Pre). Oct 19 19:09:26 volumio systemd[1]: Reached target Remote File Systems. Oct 19 19:09:26 volumio alsactl[2300]: /usr/sbin/alsactl: set_control:1461Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Oct 19 19:09:26 volumio alsactl[2300]: /usr/sbin/alsactl: set_control:1461Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Oct 19 19:09:26 volumio kernel: out of value, fixed it Oct 19 19:09:26 volumio kernel: id=0 set inskew=0 Oct 19 19:09:26 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Oct 19 19:09:26 volumio alsactl[2301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Oct 19 19:09:26 volumio alsactl[2301]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Oct 19 19:09:26 volumio kernel: out of value, fixed it Oct 19 19:09:26 volumio kernel: id=0 set inskew=0 Oct 19 19:09:26 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Oct 19 19:09:26 volumio systemd-logind[2282]: Watching system buttons on /dev/input/event1 ( USB Keyboard) Oct 19 19:09:26 volumio systemd-logind[2282]: Watching system buttons on /dev/input/event2 ( USB Keyboard) Oct 19 19:09:26 volumio systemd-logind[2282]: Watching system buttons on /dev/input/event0 (cec_input) Oct 19 19:09:26 volumio systemd-logind[2282]: New seat seat0. Oct 19 19:09:26 volumio dbus-daemon[2276]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 19 19:09:26 volumio systemd[1]: Started Login Service. Oct 19 19:09:26 volumio systemd[1]: Started Save/Restore Sound Card State. Oct 19 19:09:26 volumio avahi-daemon[2295]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Oct 19 19:09:26 volumio avahi-daemon[2295]: Successfully dropped root privileges. Oct 19 19:09:26 volumio avahi-daemon[2295]: avahi-daemon 0.7 starting up. Oct 19 19:09:26 volumio ifup[2211]: command failed: No such device (-19) Oct 19 19:09:26 volumio kernel: nf_tables: (c) 2007-2009 Patrick McHardy Oct 19 19:09:26 volumio avahi-daemon[2295]: Successfully called chroot(). Oct 19 19:09:26 volumio kernel: nf_tables_compat: (c) 2012 Pablo Neira Ayuso Oct 19 19:09:26 volumio avahi-daemon[2295]: Successfully dropped remaining capabilities. Oct 19 19:09:26 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Oct 19 19:09:26 volumio avahi-daemon[2295]: No service file found in /etc/avahi/services. Oct 19 19:09:26 volumio avahi-daemon[2295]: Network interface enumeration completed. Oct 19 19:09:26 volumio avahi-daemon[2295]: Server startup complete. Host name is volumio.local. Local service cookie is 1696728070. Oct 19 19:09:26 volumio systemd[1]: Reached target Sound Card. Oct 19 19:09:26 volumio sh[2207]: eth0=eth0 Oct 19 19:09:26 volumio systemd[1]: Started WPA supplicant. Oct 19 19:09:26 volumio wpa_supplicant[2279]: Successfully initialized wpa_supplicant Oct 19 19:09:26 volumio dhcpcd[2284]: no interfaces have a carrier Oct 19 19:09:26 volumio dhcpcd[2284]: no interfaces have a carrier Oct 19 19:09:26 volumio dhcpcd[2284]: forked to background, child pid 2358 Oct 19 19:09:26 volumio dhcpcd[2284]: forked to background, child pid 2358 Oct 19 19:09:26 volumio dhcpcd[2358]: eth0: waiting for carrier Oct 19 19:09:26 volumio systemd[1]: Started DHCP Client Daemon. Oct 19 19:09:26 volumio kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Oct 19 19:09:26 volumio volumio-remote-updater[2267]: Error: No active session Oct 19 19:09:26 volumio volumio-remote-updater[2267]: [2024-10-19 19:09:26] [info] asio async_connect error: system:111 (Connection refused) Oct 19 19:09:26 volumio volumio-remote-updater[2267]: [2024-10-19 19:09:26] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 19 19:09:26 volumio volumio-remote-updater[2267]: [2024-10-19 19:09:26] [error] handle_connect error: Underlying Transport Error Oct 19 19:09:27 volumio volumio[2290]: Could not open config: /tmp/upmpdcli.conf Oct 19 19:09:27 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 19 19:09:27 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 19 19:09:27 volumio systemd[1]: Started Raise network interfaces. Oct 19 19:09:27 volumio systemd[1]: Reached target Network. Oct 19 19:09:27 volumio systemd[1]: Starting Network Time Service... Oct 19 19:09:27 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Oct 19 19:09:27 volumio systemd[1]: Reached target Network is Online. Oct 19 19:09:27 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Oct 19 19:09:27 volumio systemd[1]: Starting Samba NMB Daemon... Oct 19 19:09:27 volumio systemd[1]: Starting /etc/rc.local Compatibility... Oct 19 19:09:27 volumio systemd[1]: Starting Permit User Sessions... Oct 19 19:09:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 19:09:27 volumio systemd[1]: Started Permit User Sessions. Oct 19 19:09:27 volumio ntpd[2417]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 19 19:09:27 volumio ntpd[2417]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 19 19:09:27 volumio rc.local[2422]: Simple mixer control 'Audio hdmi-out mute',0 Oct 19 19:09:27 volumio rc.local[2422]: Capabilities: pswitch pswitch-joined Oct 19 19:09:27 volumio rc.local[2422]: Playback channels: Mono Oct 19 19:09:27 volumio rc.local[2422]: Mono: Playback [off] Oct 19 19:09:27 volumio systemd[1]: Started Network Time Service. Oct 19 19:09:27 volumio systemd[1]: Started /etc/rc.local Compatibility. Oct 19 19:09:27 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Oct 19 19:09:27 volumio ntpd[2433]: proto: precision = 0.791 usec (-20) Oct 19 19:09:27 volumio systemd[1]: Starting Hold until boot process finishes up... Oct 19 19:09:27 volumio ntpd[2433]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 19 19:09:27 volumio ntpd[2433]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 19 19:09:27 volumio ntpd[2433]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 662 days ago Oct 19 19:09:27 volumio ntpd[2433]: Listen and drop on 0 v6wildcard [::]:123 Oct 19 19:09:27 volumio ntpd[2433]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 19 19:09:27 volumio ntpd[2433]: Listen normally on 2 lo 127.0.0.1:123 Oct 19 19:09:27 volumio ntpd[2433]: Listening on routing socket on fd #19 for interface updates Oct 19 19:09:27 volumio ntpd[2433]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 19:09:27 volumio ntpd[2433]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 19:09:27 volumio lircd-setup[2287]: /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. Oct 19 19:09:27 volumio lircd-setup[2287]: parser = configparser.SafeConfigParser() Oct 19 19:09:27 volumio systemd[1]: lircd-setup.service: Succeeded. Oct 19 19:09:27 volumio systemd[1]: Started lircd(8) initialization helper tool. Oct 19 19:09:27 volumio systemd[1]: Starting Flexible IR remote input/output application support... Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Info: lircd: Opening log, level: Info Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Version: lircd 0.10.1 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: System info: Linux volumio 4.9.241+ #15 SMP PREEMPT Thu Feb 10 11:27:37 CET 2022 aarch64 GNU/Linux Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Info: Initial device: auto Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Info: Initial device: auto Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: driver: devinput Oct 19 19:09:27 volumio lircd[2442]: lircd-0.10.1[2442]: Info: lircd: Opening log, level: Info Oct 19 19:09:27 volumio lircd[2442]: lircd-0.10.1[2442]: Notice: Using systemd fd Oct 19 19:09:27 volumio lircd[2442]: lircd-0.10.1[2442]: Warning: Running as root Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: output: /var/run/lirc/lircd Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: nodaemon: 1 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: logfile: syslog Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: immediate-init: 0 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: permission: 666 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: driver-options: Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: listen: 0 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: connect: (null) Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: userelease: 0 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: effective_user: (null) Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: release_suffix: _EVUP Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: allow_simulate: 0 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: repeat_max: 600 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: configfile: /etc/lirc/lircd.conf Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Options: dynamic_codes: (null) Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Current driver: devinput Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Driver API version: 4 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Driver version: 0.10.0 Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/devinput.html Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Info: lircd: Opening log, level: Info Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: Using systemd fd Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Warning: Running as root Oct 19 19:09:27 volumio lircd[2442]: lircd-0.10.1[2442]: Info: Using remote: odroid. Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Info: Using remote: odroid. Oct 19 19:09:27 volumio lircd-0.10.1[2442]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Oct 19 19:09:27 volumio lircd[2442]: lircd-0.10.1[2442]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Oct 19 19:09:27 volumio systemd[1]: Started Flexible IR remote input/output application support. Oct 19 19:09:27 volumio systemd[1]: iptables.service: Succeeded. Oct 19 19:09:27 volumio haveged[2254]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Oct 19 19:09:27 volumio haveged[2254]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Oct 19 19:09:27 volumio haveged[2254]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00443 Oct 19 19:09:27 volumio haveged[2254]: haveged: fills: 0, generated: 0 Oct 19 19:09:27 volumio nmbd[2429]: [2024/10/19 19:09:27.966355, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 19 19:09:27 volumio nmbd[2429]: started asyncdns process 2452 Oct 19 19:09:27 volumio nmbd[2429]: [2024/10/19 19:09:27.968385, 0] ../lib/util/become_daemon.c:149(daemon_status) Oct 19 19:09:27 volumio nmbd[2429]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Oct 19 19:09:27 volumio nmbd[2429]: [2024/10/19 19:09:27.968590, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Oct 19 19:09:27 volumio nmbd[2429]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Oct 19 19:09:28 volumio kernel: fb: malloc_osd_memory, cma:ffffff800a8a1b30 Oct 19 19:09:28 volumio kernel: fb: malloc_osd_memory, 1231, base:0x00000000cf400000, size:8388608 Oct 19 19:09:28 volumio kernel: fb: use ion buffer for fb memory, fb_index=1 Oct 19 19:09:28 volumio kernel: fb: OSD1 as afbcd mode,afbc_type=2 Oct 19 19:09:28 volumio kernel: meson-fb meson-fb: create ion_client ffffffc01e4d6240, handle=ffffffc0c7562c80 Oct 19 19:09:28 volumio kernel: meson-fb meson-fb: ion memory(1): created fb at 0x00000000ea400000, size 1 MiB Oct 19 19:09:28 volumio kernel: fb: 1, phy: 0x00000000ea400000, vir:0xffffff800f945000, size=1024K Oct 19 19:09:28 volumio kernel: fb: Frame buffer memory assigned at Oct 19 19:09:28 volumio kernel: fb: 1, phy: 0x00000000ea400000, vir:0xffffff800f945000, size=1024K Oct 19 19:09:28 volumio kernel: fb: 1, phy: 0x00000000ea400000, vir:0xffffff800f945000, size=1024K Oct 19 19:09:28 volumio kernel: fb: logo_index=0,fb_index=1 Oct 19 19:09:28 volumio kernel: fb: ---------------clear fb1 memory ffffff800f945000 Oct 19 19:09:28 volumio kernel: fb: osd[1] canvas.idx =0x43 Oct 19 19:09:28 volumio kernel: fb: osd[1] canvas.addr=0xea400000 Oct 19 19:09:28 volumio kernel: fb: osd[1] canvas.width=128 Oct 19 19:09:28 volumio kernel: fb: osd[1] canvas.height=32 Oct 19 19:09:28 volumio kernel: fb: osd[1] frame.width=32 Oct 19 19:09:28 volumio kernel: fb: osd[1] frame.height=32 Oct 19 19:09:28 volumio kernel: fb: osd[1] out_addr_id =0x2 Oct 19 19:09:28 volumio kernel: fb: malloc_osd_memory, cma:ffffff800a8a1b30 Oct 19 19:09:28 volumio kernel: fb: malloc_osd_memory, 1231, base:0x00000000cf400000, size:8388608 Oct 19 19:09:28 volumio kernel: fb: use ion buffer for fb memory, fb_index=2 Oct 19 19:09:28 volumio kernel: fb: OSD2 as afbcd mode,afbc_type=2 Oct 19 19:09:28 volumio kernel: meson-fb meson-fb: create ion_client ffffffc01e4d6240, handle=ffffffc0c0419140 Oct 19 19:09:28 volumio kernel: meson-fb meson-fb: ion memory(2): created fb at 0x00000000ea500000, size 1 MiB Oct 19 19:09:28 volumio kernel: fb: 2, phy: 0x00000000ea500000, vir:0xffffff800fa46000, size=1024K Oct 19 19:09:28 volumio kernel: fb: Frame buffer memory assigned at Oct 19 19:09:28 volumio kernel: fb: 2, phy: 0x00000000ea500000, vir:0xffffff800fa46000, size=1024K Oct 19 19:09:28 volumio kernel: fb: 2, phy: 0x00000000ea500000, vir:0xffffff800fa46000, size=1024K Oct 19 19:09:28 volumio kernel: fb: logo_index=0,fb_index=2 Oct 19 19:09:28 volumio kernel: fb: ---------------clear fb2 memory ffffff800fa46000 Oct 19 19:09:28 volumio kernel: fb: osd[2] canvas.idx =0x41 Oct 19 19:09:28 volumio kernel: fb: osd[2] canvas.addr=0xea500000 Oct 19 19:09:28 volumio kernel: fb: osd[2] canvas.width=128 Oct 19 19:09:28 volumio kernel: fb: osd[2] canvas.height=32 Oct 19 19:09:28 volumio kernel: fb: osd[2] frame.width=32 Oct 19 19:09:28 volumio kernel: fb: osd[2] frame.height=32 Oct 19 19:09:28 volumio kernel: fb: osd[2] out_addr_id =0x3 Oct 19 19:09:28 volumio kernel: fb: vpu clkc clock is 199 MHZ Oct 19 19:09:28 volumio kernel: vpu: switch_vpu_mem_pd: unsupport vpu mod: 18 Oct 19 19:09:28 volumio kernel: vpu: switch_vpu_mem_pd: unsupport vpu mod: 22 Oct 19 19:09:28 volumio kernel: vpu: switch_vpu_mem_pd: unsupport vpu mod: 53 Oct 19 19:09:28 volumio kernel: fb: malloc_osd_memory, cma:ffffff800a8a1b30 Oct 19 19:09:28 volumio kernel: fb: malloc_osd_memory, 1231, base:0x00000000cf400000, size:8388608 Oct 19 19:09:28 volumio kernel: fb: use ion buffer for fb memory, fb_index=3 Oct 19 19:09:28 volumio kernel: fb: OSD3 as afbcd mode,afbc_type=2 Oct 19 19:09:28 volumio kernel: meson-fb meson-fb: create ion_client ffffffc01e4d6240, handle=ffffffc0c7562d80 Oct 19 19:09:28 volumio kernel: meson-fb meson-fb: ion memory(3): created fb at 0x00000000ea600000, size 8 MiB Oct 19 19:09:28 volumio kernel: fb: 3, phy: 0x00000000ea600000, vir:0xffffff800fb47000, size=8192K Oct 19 19:09:28 volumio kernel: fb: Frame buffer memory assigned at Oct 19 19:09:28 volumio kernel: fb: 3, phy: 0x00000000ea600000, vir:0xffffff800fb47000, size=8192K Oct 19 19:09:28 volumio kernel: fb: 3, phy: 0x00000000ea600000, vir:0xffffff800fb47000, size=8192K Oct 19 19:09:28 volumio kernel: fb: logo_index=0,fb_index=3 Oct 19 19:09:28 volumio kernel: fb: ---------------clear fb3 memory ffffff800fb47000 Oct 19 19:09:28 volumio kernel: fb: osd[3] canvas.idx =0x42 Oct 19 19:09:28 volumio kernel: fb: osd[3] canvas.addr=0xea600000 Oct 19 19:09:28 volumio kernel: fb: osd[3] canvas.width=128 Oct 19 19:09:28 volumio kernel: fb: osd[3] canvas.height=32 Oct 19 19:09:28 volumio kernel: fb: osd[3] frame.width=32 Oct 19 19:09:28 volumio kernel: fb: osd[3] frame.height=32 Oct 19 19:09:28 volumio kernel: fb: osd[3] out_addr_id =0x4 Oct 19 19:09:28 volumio systemd[1]: Received SIGRTMIN+21 from PID 1968 (plymouthd). Oct 19 19:09:28 volumio systemd[1]: Received SIGRTMIN+21 from PID 1968 (plymouthd). Oct 19 19:09:28 volumio kernel: fb: osd_release now.index=3,open_count=1 Oct 19 19:09:28 volumio kernel: fb: osd_release now.index=2,open_count=1 Oct 19 19:09:28 volumio kernel: fb: osd_release now.index=1,open_count=1 Oct 19 19:09:28 volumio loadcpufreq[2315]: Loading cpufreq kernel modules...error: unexpectedly disconnected from boot status daemon Oct 19 19:09:28 volumio systemd[1]: plymouth-quit.service: Succeeded. Oct 19 19:09:28 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Oct 19 19:09:28 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Oct 19 19:09:28 volumio systemd[1]: Started Hold until boot process finishes up. Oct 19 19:09:28 volumio ifplugd[2418]: Network Interface Plugging Daemon...error: unexpectedly disconnected from boot status daemon Oct 19 19:09:28 volumio systemd[1]: Started Serial Getty on ttyS0. Oct 19 19:09:28 volumio ifplugd(eth0)[2471]: ifplugd 0.28 initializing. Oct 19 19:09:28 volumio ifplugd(eth0)[2471]: Using interface eth0/00:1E:06:48:2E:58 with driver (version: Jan_2016) Oct 19 19:09:28 volumio ifplugd(eth0)[2471]: Using detection mode: SIOCETHTOOL Oct 19 19:09:28 volumio ifplugd(eth0)[2471]: Initialization complete, link beat not detected. Oct 19 19:09:28 volumio systemd[1]: Started Getty on tty1. Oct 19 19:09:28 volumio systemd[1]: Reached target Login Prompts. Oct 19 19:09:28 volumio ifplugd[2418]: start eth0...done. Oct 19 19:09:28 volumio systemd[1]: Started LSB: Brings up/down network automatically. Oct 19 19:09:28 volumio loadcpufreq[2315]: done (none). Oct 19 19:09:28 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 19 19:09:28 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 19 19:09:28 volumio cpufrequtils[2509]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Oct 19 19:09:28 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 19 19:09:28 volumio ntpd[2433]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 19 19:09:28 volumio wireless.js[2291]: WIRELESS: No wireless interface, exiting Oct 19 19:09:28 volumio iw[2525]: command failed: No such device (-19) Oct 19 19:09:28 volumio iwconfig[2528]: Error for wireless request "Set Power Management" (8B2C) : Oct 19 19:09:28 volumio iwconfig[2528]: SET failed on device wlan0 ; No such device. Oct 19 19:09:28 volumio systemd[1]: wireless.service: Succeeded. Oct 19 19:09:28 volumio systemd[1]: Started Wireless Services. Oct 19 19:09:28 volumio systemd[1]: Started Volumio Backend Module. Oct 19 19:09:28 volumio systemd[1]: Started Volumio Cpu Tweaker. Oct 19 19:09:28 volumio volumio-cpu-tweak[2532]: Setting RT Priority for mpd Oct 19 19:09:28 volumio volumio-cpu-tweak[2532]: chrt: cannot obtain the list of tasks: No such file or directory Oct 19 19:09:28 volumio volumio-cpu-tweak[2532]: Setting MPD Affinity Oct 19 19:09:28 volumio volumio-cpu-tweak[2532]: pid 3's current affinity mask: 1 Oct 19 19:09:28 volumio volumio-cpu-tweak[2532]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 19 19:09:28 volumio volumio-cpu-tweak[2532]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 19 19:09:28 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 19 19:09:29 volumio ntpd[2433]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 19 19:09:30 volumio ntpd[2433]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 19 19:09:30 volumio dhcpcd[2358]: eth0: carrier acquired Oct 19 19:09:30 volumio kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 19 19:09:30 volumio dhcpcd[2358]: DUID 00:01:00:01:2d:f7:8e:5d:00:1e:06:48:2e:58 Oct 19 19:09:30 volumio dhcpcd[2358]: eth0: IAID 06:48:2e:58 Oct 19 19:09:30 volumio dhcpcd[2358]: eth0: adding address fe80::21e:6ff:fe48:2e58 Oct 19 19:09:30 volumio dhcpcd[2358]: ipv6_addaddr1: Permission denied Oct 19 19:09:30 volumio dhcpcd[2358]: eth0: probing address 192.168.1.16/24 Oct 19 19:09:30 volumio volumio[2531]: info: ------------------------------------------- Oct 19 19:09:30 volumio volumio[2531]: info: ----- Volumio3 ---- Oct 19 19:09:30 volumio volumio[2531]: info: ------------------------------------------- Oct 19 19:09:30 volumio volumio[2531]: info: ----- System startup ---- Oct 19 19:09:30 volumio volumio[2531]: info: ------------------------------------------- Oct 19 19:09:30 volumio dhcpcd[2358]: eth0: soliciting an IPv6 router Oct 19 19:09:31 volumio ifplugd(eth0)[2471]: Link beat detected. Oct 19 19:09:31 volumio ntpd[2433]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 19 19:09:31 volumio ifplugd(eth0)[2471]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 19 19:09:31 volumio ifplugd(eth0)[2471]: client: ifup: interface eth0 already configured Oct 19 19:09:31 volumio volumio[2531]: info: MYVOLUMIO Environment detected Oct 19 19:09:31 volumio ifplugd(eth0)[2471]: Program executed successfully. Oct 19 19:09:31 volumio volumio[2531]: info: Plugin folders cleanup Oct 19 19:09:31 volumio volumio[2531]: info: Scanning into folder /volumio/app/plugins/ Oct 19 19:09:31 volumio volumio[2531]: info: Scanning category audio_interface Oct 19 19:09:31 volumio volumio[2531]: info: Scanning category miscellanea Oct 19 19:09:31 volumio volumio[2531]: info: Scanning category music_service Oct 19 19:09:31 volumio volumio[2531]: info: Scanning category plugins.json Oct 19 19:09:31 volumio volumio[2531]: info: Scanning category system_controller Oct 19 19:09:31 volumio volumio[2531]: info: Scanning category user_interface Oct 19 19:09:31 volumio volumio[2531]: info: Scanning into folder /data/plugins/ Oct 19 19:09:31 volumio volumio[2531]: info: Plugin folders cleanup completed Oct 19 19:09:31 volumio volumio[2531]: info: ------------------------------------------- Oct 19 19:09:31 volumio volumio[2531]: info: ----- Core plugins startup ---- Oct 19 19:09:31 volumio volumio[2531]: info: ------------------------------------------- Oct 19 19:09:31 volumio volumio[2531]: info: Loading plugins from folder /volumio/app/plugins/ Oct 19 19:09:31 volumio volumio[2531]: info: Adding plugin upnp to MyMusic Plugins Oct 19 19:09:31 volumio volumio[2531]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 19 19:09:31 volumio volumio[2531]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 19 19:09:31 volumio volumio[2531]: info: Loading plugins from folder /data/plugins/ Oct 19 19:09:31 volumio volumio[2531]: info: Loading plugin "system"... Oct 19 19:09:31 volumio volumio[2531]: info: Loading plugin "appearance"... Oct 19 19:09:31 volumio volumio-remote-updater[2267]: [2024-10-19 19:09:31] [connect] Successful connection Oct 19 19:09:32 volumio volumio[2531]: info: Loading plugin "network"... Oct 19 19:09:32 volumio volumio[2531]: info: Refreshing Cached IP Addresses Oct 19 19:09:32 volumio volumio[2531]: info: Loading plugin "services"... Oct 19 19:09:32 volumio volumio[2531]: info: Loading plugin "alsa_controller"... Oct 19 19:09:32 volumio sudo[2570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 19 19:09:32 volumio sudo[2568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 19 19:09:32 volumio sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 19 19:09:32 volumio sudo[2570]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:32 volumio sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:32 volumio sudo[2568]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:32 volumio sudo[2568]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:32 volumio sudo[2572]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:32 volumio sudo[2570]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:32 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 19 19:09:32 volumio volumio[2531]: info: Loading plugin "wizard"... Oct 19 19:09:32 volumio volumio[2531]: info: Loading plugin "networkfs"... Oct 19 19:09:32 volumio volumio[2531]: info: Starting Udev Watcher for removable devices Oct 19 19:09:32 volumio sudo[2585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.20:samba/files /mnt/NAS/SAMBA Oct 19 19:09:32 volumio sudo[2585]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:33 volumio sudo[2587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=smbuser,password=214365,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.20/FILES/music /mnt/NAS/SAMBA Oct 19 19:09:33 volumio sudo[2587]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:33 volumio volumio[2531]: info: Ignoring mount for partition: boot Oct 19 19:09:33 volumio volumio[2531]: info: Ignoring mount for partition: volumio Oct 19 19:09:33 volumio volumio[2531]: info: Ignoring mount for partition: volumio_data Oct 19 19:09:33 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "volumio_command_line_client"... Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "upnp"... Oct 19 19:09:33 volumio volumio[2531]: info: [1729354173027] Starting Upmpd Daemon Oct 19 19:09:33 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "my_music"... Oct 19 19:09:33 volumio kernel: FS-Cache: Loaded Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "mpd"... Oct 19 19:09:33 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Oct 19 19:09:33 volumio kernel: Key type cifs.spnego registered Oct 19 19:09:33 volumio kernel: Key type cifs.idmap registered Oct 19 19:09:33 volumio kernel: FS-Cache: Netfs 'nfs' registered for caching Oct 19 19:09:33 volumio sudo[2587]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:33 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 19 19:09:33 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -101 Oct 19 19:09:33 volumio kernel: NFS: Registering the id_resolver key type Oct 19 19:09:33 volumio kernel: Key type id_resolver registered Oct 19 19:09:33 volumio kernel: Key type id_legacy registered Oct 19 19:09:33 volumio sudo[2585]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "upnp_browser"... Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "alarm-clock"... Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "airplay_emulation"... Oct 19 19:09:33 volumio volumio[2531]: info: Starting Shairport Sync Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "last_100"... Oct 19 19:09:33 volumio volumio[2531]: info: Loading plugin "webradio"... Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "i2s_dacs"... Oct 19 19:09:34 volumio volumio[2531]: info: I2S DAC not set, start Auto-detection Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "volumiodiscovery"... Oct 19 19:09:34 volumio volumio[2531]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 19 19:09:34 volumio volumio[2531]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 19:09:34 volumio volumio[2531]: *** WARNING *** For more information see Oct 19 19:09:34 volumio node[2531]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 19 19:09:34 volumio volumio[2531]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 19 19:09:34 volumio volumio[2531]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 19:09:34 volumio volumio[2531]: *** WARNING *** For more information see Oct 19 19:09:34 volumio node[2531]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 19:09:34 volumio node[2531]: *** WARNING *** For more information see Oct 19 19:09:34 volumio node[2531]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 19 19:09:34 volumio node[2531]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 19 19:09:34 volumio node[2531]: *** WARNING *** For more information see Oct 19 19:09:34 volumio volumio[2531]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 19 19:09:34 volumio volumio[2531]: info: Discovery: Started advertising with name: Volumio Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "outputs"... Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "albumart"... Oct 19 19:09:34 volumio volumio[2531]: info: Plugin example_plugin is not enabled Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "inputs"... Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "updater_comm"... Oct 19 19:09:34 volumio volumio[2531]: info: Plugin mpdemulation is not enabled Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "rest_api"... Oct 19 19:09:34 volumio volumio[2531]: info: Loading plugin "websocket"... Oct 19 19:09:34 volumio volumio[2531]: info: Starting Socket.io Server version 2.3.0 Oct 19 19:09:34 volumio volumio[2531]: info: Loading i18n strings for locale ru Oct 19 19:09:34 volumio volumio[2531]: Updating browse sources language Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 19:09:34 volumio volumio[2531]: Forking 3 albumart workers Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::initPlayerControls Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: Express server listening on port 3000 Oct 19 19:09:34 volumio volumio[2531]: [Metrics] WebUI: 4s 853.85ms Oct 19 19:09:34 volumio volumio[2531]: info: CoreStateMachine::resetVolumioState Oct 19 19:09:34 volumio volumio[2531]: info: CoreStateMachine::getcurrentVolume Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::volumioRetrievevolume Oct 19 19:09:34 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 19:09:34 volumio volumio[2531]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 19 19:09:34 volumio volumio[2531]: info: Completed loading Core Plugins Oct 19 19:09:34 volumio volumio[2531]: info: Preparing to generate the ALSA configuration file Oct 19 19:09:34 volumio volumio[2531]: info: Cannot read play queue from file Oct 19 19:09:34 volumio volumio[2531]: info: Cannot mount NAS SAMBA at system boot, trial number 1 ,retrying in 5 seconds Oct 19 19:09:34 volumio volumio[2531]: info: Cannot mount NAS SAMBA at system boot, trial number 1 ,retrying in 5 seconds Oct 19 19:09:34 volumio volumio[2531]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 19 19:09:34 volumio volumio[2531]: wlan0 Interface doesn't support scanning. Oct 19 19:09:34 volumio volumio[2531]: info: Cannot use regular scanning, forcing with ap-force Oct 19 19:09:35 volumio sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 19 19:09:35 volumio sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:35 volumio sudo[2637]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:35 volumio volumio[2531]: command failed: No such device (-19) Oct 19 19:09:35 volumio volumio[2531]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 19 19:09:35 volumio volumio[2531]: command failed: No such device (-19) Oct 19 19:09:35 volumio volumio-remote-updater[2267]: [2024-10-19 19:09:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1729354171 101 Oct 19 19:09:35 volumio dhcpcd[2358]: eth0: using static address 192.168.1.16/24 Oct 19 19:09:35 volumio dhcpcd[2358]: eth0: adding route to 192.168.1.0/24 Oct 19 19:09:35 volumio avahi-daemon[2295]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.16. Oct 19 19:09:35 volumio dhcpcd[2358]: eth0: adding default route via 192.168.1.1 Oct 19 19:09:35 volumio avahi-daemon[2295]: New relevant interface eth0.IPv4 for mDNS. Oct 19 19:09:35 volumio avahi-daemon[2295]: Registering new address record for 192.168.1.16 on eth0.IPv4. Oct 19 19:09:35 volumio volumio[2531]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Oct 19 19:09:35 volumio volumio[2531]: Unable to parse: Oct 19 19:09:35 volumio volumio[2531]: Simple mixer control 'Audio hdmi-out mute',0 Oct 19 19:09:35 volumio volumio[2531]: Capabilities: pswitch pswitch-joined Oct 19 19:09:35 volumio volumio[2531]: Playback channels: Mono Oct 19 19:09:35 volumio volumio[2531]: Mono: Playback [off] Oct 19 19:09:35 volumio volumio[2531]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 19 19:09:35 volumio volumio[2531]: info: Asound.conf file unchanged, so no further update is needed Oct 19 19:09:35 volumio volumio[2531]: info: Output device has changed, restarting MPD Oct 19 19:09:35 volumio volumio[2531]: info: Output device has changed, restarting Shairport Sync Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 19:09:35 volumio sudo[2658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 19 19:09:35 volumio sudo[2658]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:35 volumio volumio[2531]: Starting albumart workers Oct 19 19:09:35 volumio sudo[2663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 19:09:35 volumio sudo[2663]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:35 volumio sudo[2658]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:35 volumio volumio[2531]: Starting albumart workers Oct 19 19:09:35 volumio volumio[2531]: Starting albumart workers Oct 19 19:09:35 volumio systemd[1]: Listening on mpd.socket. Oct 19 19:09:35 volumio systemd[1]: Starting Music Player Daemon... Oct 19 19:09:35 volumio volumio[2531]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 19:09:35 volumio volumio[2531]: info: ___________ START PLUGINS ___________ Oct 19 19:09:35 volumio volumio[2531]: info: ControllerMpd::onStart: Initializing MPD Oct 19 19:09:35 volumio volumio[2531]: info: Creating MPD Configuration file Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 19 19:09:35 volumio volumio[2531]: info: [1729354175435] CoreMusicLibrary::Adding element Медиа-серверы Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 19:09:35 volumio sudo[2674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 19 19:09:35 volumio sudo[2674]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:35 volumio sudo[2676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 19:09:35 volumio sudo[2676]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:35 volumio sudo[2674]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 19:09:35 volumio sudo[2672]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 19 19:09:35 volumio sudo[2672]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:35 volumio sudo[2672]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 19 19:09:35 volumio sudo[2672]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:35 volumio systemd[1]: mpd.service: Succeeded. Oct 19 19:09:35 volumio systemd[1]: Stopped Music Player Daemon. Oct 19 19:09:35 volumio systemd[1]: Starting Music Player Daemon... Oct 19 19:09:35 volumio volumio[2531]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 19:09:35 volumio volumio[2531]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 19 19:09:35 volumio volumio[2531]: info: [1729354175659] CoreMusicLibrary::Adding element Last_100 Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 19 19:09:35 volumio volumio[2531]: info: [1729354175663] CoreMusicLibrary::Adding element Webradio Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 19 19:09:35 volumio volumio[2531]: info: Initializing BBC Radios Oct 19 19:09:35 volumio sudo[2683]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 19 19:09:35 volumio sudo[2683]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:35 volumio sudo[2683]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 19 19:09:35 volumio sudo[2683]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 19 19:09:35 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 19:09:35 volumio volumio[2531]: info: Volumio Calling Home Oct 19 19:09:36 volumio volumio[2531]: info: CoreStateMachine::setRepeat null single undefined Oct 19 19:09:36 volumio volumio[2531]: info: CoreStateMachine::pushState Oct 19 19:09:36 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::volumioPushState Oct 19 19:09:36 volumio volumio[2531]: info: CoreStateMachine::setRandom null Oct 19 19:09:36 volumio volumio[2531]: info: CoreStateMachine::pushState Oct 19 19:09:36 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::volumioPushState Oct 19 19:09:36 volumio volumio[2531]: Unable to parse: Oct 19 19:09:36 volumio volumio[2531]: Simple mixer control 'Audio hdmi-out mute',0 Oct 19 19:09:36 volumio volumio[2531]: Capabilities: pswitch pswitch-joined Oct 19 19:09:36 volumio volumio[2531]: Playback channels: Mono Oct 19 19:09:36 volumio volumio[2531]: Mono: Playback [off] Oct 19 19:09:36 volumio volumio[2531]: info: VolumeController:: Volume=undefined Mute =false Oct 19 19:09:36 volumio volumio[2531]: info: CoreStateMachine::pushState Oct 19 19:09:36 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::volumioPushState Oct 19 19:09:36 volumio volumio[2531]: info: CoreStateMachine::updateTrackBlock Oct 19 19:09:36 volumio volumio[2531]: info: CorePlayQueue::getTrackBlock Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::volumioRetrievevolume Oct 19 19:09:36 volumio volumio[2531]: info: MPD Permissions set Oct 19 19:09:36 volumio volumio[2531]: info: MPD Permissions set Oct 19 19:09:36 volumio volumio[2531]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 19 19:09:36 volumio volumio[2531]: Unable to parse: Oct 19 19:09:36 volumio volumio[2531]: Simple mixer control 'Audio hdmi-out mute',0 Oct 19 19:09:36 volumio volumio[2531]: Capabilities: pswitch pswitch-joined Oct 19 19:09:36 volumio volumio[2531]: Playback channels: Mono Oct 19 19:09:36 volumio volumio[2531]: Mono: Playback [off] Oct 19 19:09:36 volumio volumio[2531]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 19:09:36 volumio volumio[2531]: info: Discovery: adding 08fd1e10-c302-49b0-bf10-db48b51ac3b4 Oct 19 19:09:36 volumio volumio[2531]: info: Discovery: Found device Volumio Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::volumioGetState Oct 19 19:09:36 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:36 volumio ntpd[2433]: Listen normally on 3 eth0 192.168.1.16:123 Oct 19 19:09:36 volumio ntpd[2433]: new interface(s) found: waking up resolver Oct 19 19:09:36 volumio volumio[2531]: info: Volumio called home Oct 19 19:09:36 volumio volumio[2531]: Unable to parse: Oct 19 19:09:36 volumio volumio[2531]: Simple mixer control 'Audio hdmi-out mute',0 Oct 19 19:09:36 volumio volumio[2531]: Capabilities: pswitch pswitch-joined Oct 19 19:09:36 volumio volumio[2531]: Playback channels: Mono Oct 19 19:09:36 volumio volumio[2531]: Mono: Playback [off] Oct 19 19:09:36 volumio volumio[2531]: info: VolumeController:: Volume=undefined Mute =false Oct 19 19:09:36 volumio volumio[2531]: info: CoreStateMachine::pushState Oct 19 19:09:36 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::volumioPushState Oct 19 19:09:36 volumio volumio[2531]: info: Starting Shairport Sync Oct 19 19:09:36 volumio volumio[2531]: info: Starting Shairport Sync Oct 19 19:09:36 volumio sudo[2742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 19:09:36 volumio volumio[2531]: info: Starting Shairport Sync Oct 19 19:09:36 volumio sudo[2742]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:36 volumio sudo[2744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 19:09:36 volumio sudo[2744]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 19:09:36 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 19 19:09:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 19 19:09:36 volumio volumio[2531]: info: CoreCommandRouter::volumioGetState Oct 19 19:09:36 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 19:09:36 volumio sudo[2747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 19:09:36 volumio sudo[2747]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:36 volumio sudo[2742]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 19:09:36 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 19 19:09:36 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 19 19:09:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 19 19:09:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 19:09:36 volumio sudo[2744]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:36 volumio volumio[2531]: info: Shairport-Sync Started Oct 19 19:09:36 volumio volumio[2531]: Error adding Membership: Error: addMembership EINVAL Oct 19 19:09:36 volumio sudo[2747]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:36 volumio volumio[2531]: info: Shairport-Sync Started Oct 19 19:09:36 volumio volumio[2531]: info: Shairport-Sync Started Oct 19 19:09:37 volumio sudo[2756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 19 19:09:37 volumio sudo[2756]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:37 volumio sudo[2756]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:37 volumio sudo[2758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 19 19:09:37 volumio sudo[2758]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:37 volumio sudo[2758]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:37 volumio volumio[2531]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.4 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 OPR/114.0.0.0 (Edition Yx 05) Engine version: 3 Transport: polling Total Clients: 3 Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::volumioGetBrowseSources Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::volumioGetState Oct 19 19:09:37 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 19:09:37 volumio mpd[2695]: Oct 19 19:09 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 19 19:09:37 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 19 19:09:37 volumio systemd[1]: Started Music Player Daemon. Oct 19 19:09:37 volumio sudo[2663]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:37 volumio sudo[2676]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:37 volumio volumio[2531]: info: Completed starting Core Plugins Oct 19 19:09:37 volumio volumio[2531]: info: ------------------------------------------- Oct 19 19:09:37 volumio volumio[2531]: info: ----- MyVolumio plugins startup ---- Oct 19 19:09:37 volumio volumio[2531]: info: ------------------------------------------- Oct 19 19:09:37 volumio volumio[2531]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 19 19:09:37 volumio volumio[2531]: info: MPD running with PID2695 Oct 19 19:09:37 volumio volumio[2531]: ,establishing connection Oct 19 19:09:37 volumio nmbd[2429]: [2024/10/19 19:09:37.985639, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 19 19:09:37 volumio nmbd[2429]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 19 19:09:37 volumio systemd[1]: Started Samba NMB Daemon. Oct 19 19:09:37 volumio systemd[1]: Starting Samba Winbind Daemon... Oct 19 19:09:38 volumio volumio[2531]: error: MPD error: The expression evaluated to a falsy value: Oct 19 19:09:38 volumio volumio[2531]: assert.ok(self.idling) Oct 19 19:09:38 volumio volumio[2531]: error: The expression evaluated to a falsy value: Oct 19 19:09:38 volumio volumio[2531]: assert.ok(self.idling) Oct 19 19:09:38 volumio volumio[2531]: error: MPD error: The expression evaluated to a falsy value: Oct 19 19:09:38 volumio volumio[2531]: assert.ok(self.idling) Oct 19 19:09:38 volumio volumio[2531]: error: The expression evaluated to a falsy value: Oct 19 19:09:38 volumio volumio[2531]: assert.ok(self.idling) Oct 19 19:09:38 volumio volumio[2531]: error: updateQueue error: null Oct 19 19:09:38 volumio winbindd[2773]: [2024/10/19 19:09:38.256379, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 19 19:09:38 volumio winbindd[2773]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 19 19:09:38 volumio winbindd[2773]: [2024/10/19 19:09:38.274300, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 19 19:09:38 volumio winbindd[2773]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 19 19:09:38 volumio systemd[1]: Started Samba Winbind Daemon. Oct 19 19:09:38 volumio systemd[1]: Starting Samba SMB Daemon... Oct 19 19:09:38 volumio smbd[2778]: [2024/10/19 19:09:38.650710, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 19 19:09:38 volumio smbd[2778]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 19 19:09:38 volumio systemd[1]: Started Samba SMB Daemon. Oct 19 19:09:38 volumio systemd[1]: Reached target Multi-User System. Oct 19 19:09:38 volumio systemd[1]: Reached target Graphical Interface. Oct 19 19:09:38 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 19 19:09:38 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 19 19:09:38 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 19 19:09:38 volumio systemd[1]: Startup finished in 9.958s (kernel) + 14.254s (userspace) = 24.212s. Oct 19 19:09:39 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 19 19:09:39 volumio volumio[2531]: info: Received Get System Info Oct 19 19:09:39 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 19 19:09:39 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 19 19:09:39 volumio volumio[2531]: info: Discovery: Getting this device information Oct 19 19:09:39 volumio volumio[2531]: info: CoreCommandRouter::volumioGetState Oct 19 19:09:39 volumio volumio[2531]: info: CorePlayQueue::getTrack 0 Oct 19 19:09:39 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 19 19:09:39 volumio sudo[2788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=smbuser,password=214365,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.20/FILES/music /mnt/NAS/SAMBA Oct 19 19:09:39 volumio sudo[2788]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:39 volumio sudo[2790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.20:samba/files /mnt/NAS/SAMBA Oct 19 19:09:39 volumio sudo[2790]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:40 volumio systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Oct 19 19:09:40 volumio systemd[1]: Starting Preprocess NFS configuration... Oct 19 19:09:40 volumio systemd[1]: Reached target Host and Network Name Lookups. Oct 19 19:09:40 volumio systemd[1]: nfs-config.service: Succeeded. Oct 19 19:09:40 volumio systemd[1]: Started Preprocess NFS configuration. Oct 19 19:09:40 volumio systemd[1]: Starting Notify NFS peers of a restart... Oct 19 19:09:40 volumio systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Oct 19 19:09:40 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -95 Oct 19 19:09:40 volumio sudo[2788]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:40 volumio sm-notify[2802]: Version 1.3.3 starting Oct 19 19:09:40 volumio volumio[2531]: info: Cannot mount NAS SAMBA at system boot, trial number 2 ,retrying in 5 seconds Oct 19 19:09:40 volumio systemd[1]: rpc-statd-notify.service: Succeeded. Oct 19 19:09:40 volumio systemd[1]: Started Notify NFS peers of a restart. Oct 19 19:09:40 volumio rpc.statd[2804]: Version 1.3.3 starting Oct 19 19:09:40 volumio rpc.statd[2804]: Flags: TI-RPC Oct 19 19:09:40 volumio systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Oct 19 19:09:41 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 19 19:09:42 volumio volumio[2531]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 19 19:09:43 volumio sudo[2806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 19 19:09:43 volumio sudo[2806]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:43 volumio sudo[2806]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:43 volumio sudo[2808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 19 19:09:43 volumio sudo[2808]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:43 volumio sudo[2808]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:43 volumio sudo[2813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 19 19:09:43 volumio sudo[2813]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 19:09:43 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 19 19:09:43 volumio sudo[2813]: pam_unix(sudo:session): session closed for user root Oct 19 19:09:43 volumio volumio[2531]: info: Upmpdcli Daemon Started Oct 19 19:09:43 volumio volumio[2816]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 19 19:09:44 volumio volumio[2531]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Oct 19 19:09:45 volumio volumio[2531]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 19:09:45 volumio volumio[2531]: TypeError: Cannot read property 'replace' of undefined Oct 19 19:09:45 volumio volumio[2531]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Oct 19 19:09:45 volumio volumio[2531]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Oct 19 19:09:45 volumio volumio[2531]: at listOnTimeout (internal/timers.js:557:17) Oct 19 19:09:45 volumio volumio[2531]: at processTimers (internal/timers.js:500:7) Oct 19 19:09:45 volumio volumio[2531]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 19:09:45 volumio sudo[2843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 19:08 Oct 19 19:09:45 volumio sudo[2843]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 11:32:28 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="odroidc4" VOLUMIO_DEVICENAME="Odroid-C4" VOLUMIO_HASH="bcf63729a67a1fb0048ee35bec188024"