-- Logs begin at Mon 2025-04-21 08:16:19 UTC, end at Mon 2025-04-21 08:16:52 UTC. -- Apr 21 08:16:19 volumio-n1 systemd-journal[2895]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 134.9M free of 895.5M available → current limit 30.0M). Apr 21 08:16:19 volumio-n1 kernel: Initializing cgroup subsys cpuset Apr 21 08:16:19 volumio-n1 kernel: Initializing cgroup subsys cpu Apr 21 08:16:19 volumio-n1 kernel: Initializing cgroup subsys cpuacct Apr 21 08:16:19 volumio-n1 kernel: Linux version 3.14.29-amlogics905x-gf29b82a-dirty (root@user-VirtualBox) (gcc version 6.4.1 20171012 (Linaro GCC 6.4-2017.11) ) #169 SMP PREEMPT Sun May 20 09:10:33 MSK 2018 Apr 21 08:16:19 volumio-n1 kernel: CPU: AArch64 Processor [410fd034] revision 4 Apr 21 08:16:19 volumio-n1 kernel: no prop version_code Apr 21 08:16:19 volumio-n1 kernel: fdt Reserved memory table: Apr 21 08:16:19 volumio-n1 kernel: linux,meson-fb: 0x000000007d100000 - 0x000000007f100000 (32 MiB) Apr 21 08:16:19 volumio-n1 kernel: linux,di: 0x000000007b300000 - 0x000000007d100000 (30 MiB) Apr 21 08:16:19 volumio-n1 kernel: DI: DI reserved memory: created CMA memory pool at 0x000000007b300000, size 30 MiB Apr 21 08:16:19 volumio-n1 kernel: linux,ion-dev: 0x0000000079300000 - 0x000000007b300000 (32 MiB) Apr 21 08:16:19 volumio-n1 kernel: linux,vdin1_cma: 0x0000000078000000 - 0x0000000079000000 (16 MiB) Apr 21 08:16:19 volumio-n1 kernel: cma: Reserved 16 MiB at 78000000, total cma pages:4096 Apr 21 08:16:19 volumio-n1 kernel: linux,ppmgr: 0x0000000079300000 - 0x0000000079300000 (0 MiB) Apr 21 08:16:19 volumio-n1 kernel: linux,codec_mm_cma: 0x0000000067800000 - 0x0000000073800000 (192 MiB) Apr 21 08:16:19 volumio-n1 kernel: cma: Reserved 192 MiB at 67800000, total cma pages:53248 Apr 21 08:16:19 volumio-n1 kernel: linux,picdec: 0x0000000079300000 - 0x0000000079300000 (0 MiB) Apr 21 08:16:19 volumio-n1 kernel: Reserved memory: incorrect alignment of CMA region Apr 21 08:16:19 volumio-n1 kernel: linux,codec_mm_reserved: 0x0000000073f00000 - 0x0000000078000000 (65 MiB) Apr 21 08:16:19 volumio-n1 kernel: fdt Reserved memory total: 371 MiB Apr 21 08:16:19 volumio-n1 kernel: cma: Reserved 8 MiB at 67000000, total cma pages:55296 Apr 21 08:16:19 volumio-n1 kernel: On node 0 totalpages: 510976 Apr 21 08:16:19 volumio-n1 kernel: Normal zone: 11000 pages used for memmap Apr 21 08:16:19 volumio-n1 kernel: Normal zone: 0 pages reserved Apr 21 08:16:19 volumio-n1 kernel: Normal zone: 510976 pages, LIFO batch:31 Apr 21 08:16:19 volumio-n1 kernel: psci: probing function IDs from device-tree Apr 21 08:16:19 volumio-n1 kernel: PERCPU: Embedded 13 pages/cpu @ffffffc07929b000 s20608 r8192 d24448 u53248 Apr 21 08:16:19 volumio-n1 kernel: pcpu-alloc: s20608 r8192 d24448 u53248 alloc=13*4096 Apr 21 08:16:19 volumio-n1 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Apr 21 08:16:19 volumio-n1 kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 499976 Apr 21 08:16:19 volumio-n1 kernel: Kernel command line: imgpart=LABEL=volumio imgfile=/volumio_current.sqsh bootpart=LABEL=BOOT datapart=LABEL=volumio_data rootwait rw console=ttyS0,115200n8 console=tty0 no_console_suspend consoleblank=0 fsck.fix=yes fsck.repair=yes net.ifnames=0 mac=${mac} bootdelay=5 Apr 21 08:16:19 volumio-n1 kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Apr 21 08:16:19 volumio-n1 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) Apr 21 08:16:19 volumio-n1 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) Apr 21 08:16:19 volumio-n1 kernel: Memory: 1615700K/2043904K available (10994K kernel code, 981K rwdata, 4028K rodata, 1236K init, 4557K bss, 428204K reserved) Apr 21 08:16:19 volumio-n1 kernel: Virtual kernel memory layout: vmalloc : 0xffffff8000000000 - 0xffffff8040000000 ( 1024 MB) vmemmap : 0xffffff8040010000 - 0xffffff8042b0d800 ( 42 MB) modules : 0xffffffbffc000000 - 0xffffffc000000000 ( 64 MB) memory : 0xffffffc000000000 - 0xffffffc07d100000 ( 2001 MB) .init : 0xffffffc001f2d000 - 0xffffffc002062080 ( 1237 kB) .text : 0xffffffc001080000 - 0xffffffc001f2caf4 ( 15027 kB) .data : 0xffffffc002063000 - 0xffffffc002158670 ( 982 kB) Apr 21 08:16:19 volumio-n1 kernel: PM: Registered nosave memory: [mem 0x01080000-0x01f2bfff] Apr 21 08:16:19 volumio-n1 kernel: SLUB: HWalign=64, Order=0-1, MinObjects=0, CPUs=4, Nodes=1 Apr 21 08:16:19 volumio-n1 kernel: arch_multi_cluster:0 Apr 21 08:16:19 volumio-n1 kernel: Preemptible hierarchical RCU implementation. Apr 21 08:16:19 volumio-n1 kernel: RCU debugfs-based tracing is enabled. Apr 21 08:16:19 volumio-n1 kernel: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Apr 21 08:16:19 volumio-n1 kernel: RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 21 08:16:19 volumio-n1 kernel: NR_IRQS:64 nr_irqs:64 0 Apr 21 08:16:19 volumio-n1 kernel: Architected cp15 timer(s) running at 24.00MHz (phys). Apr 21 08:16:19 volumio-n1 kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 2863311519744ns Apr 21 08:16:19 volumio-n1 kernel: meson_bc_timer: mclk->mux_reg =ffffff800000c990,mclk->reg =ffffff800000e994 Apr 21 08:16:19 volumio-n1 kernel: Console: colour dummy device 80x25 Apr 21 08:16:20 volumio-n1 kernel: console [tty0] enabled Apr 21 08:16:20 volumio-n1 kernel: allocated 8388608 bytes of page_cgroup Apr 21 08:16:20 volumio-n1 kernel: please try 'cgroup_disable=memory' option if you don't want memory cgroups Apr 21 08:16:20 volumio-n1 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=240000) Apr 21 08:16:20 volumio-n1 kernel: pid_max: default: 32768 minimum: 301 Apr 21 08:16:20 volumio-n1 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) Apr 21 08:16:20 volumio-n1 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) Apr 21 08:16:20 volumio-n1 kernel: Initializing cgroup subsys memory Apr 21 08:16:20 volumio-n1 kernel: Initializing cgroup subsys devices Apr 21 08:16:20 volumio-n1 kernel: Initializing cgroup subsys freezer Apr 21 08:16:20 volumio-n1 kernel: Initializing cgroup subsys blkio Apr 21 08:16:20 volumio-n1 kernel: Initializing cgroup subsys perf_event Apr 21 08:16:20 volumio-n1 kernel: ftrace: allocating 36702 entries in 144 pages Apr 21 08:16:20 volumio-n1 kernel: /cpus/cpu@0: Missing clock-frequency property Apr 21 08:16:20 volumio-n1 kernel: /cpus/cpu@1: Missing clock-frequency property Apr 21 08:16:20 volumio-n1 kernel: /cpus/cpu@2: Missing clock-frequency property Apr 21 08:16:20 volumio-n1 kernel: /cpus/cpu@3: Missing clock-frequency property Apr 21 08:16:20 volumio-n1 kernel: hw perfevents: enabled with arm/armv8-pmuv3 PMU driver, 7 counters available Apr 21 08:16:20 volumio-n1 kernel: Meson chip version = RevD (21:D - 4:0) Apr 21 08:16:20 volumio-n1 kernel: CPU1: Booted secondary processor Apr 21 08:16:20 volumio-n1 kernel: CPU2: Booted secondary processor Apr 21 08:16:20 volumio-n1 kernel: CPU3: Booted secondary processor Apr 21 08:16:20 volumio-n1 kernel: Brought up 4 CPUs Apr 21 08:16:20 volumio-n1 kernel: SMP: Total of 4 processors activated. Apr 21 08:16:20 volumio-n1 kernel: devtmpfs: initialized Apr 21 08:16:20 volumio-n1 kernel: sched: registering cpufreq notifiers for scale-invariant loads Apr 21 08:16:20 volumio-n1 kernel: instabooting: 0 Apr 21 08:16:20 volumio-n1 kernel: cma: cma_init_reserved_areas, use_cma_first:1 Apr 21 08:16:20 volumio-n1 kernel: xor: measuring software checksum speed Apr 21 08:16:20 volumio-n1 kernel: 8regs : 2292.000 MB/sec Apr 21 08:16:20 volumio-n1 kernel: 8regs_prefetch: 2041.200 MB/sec Apr 21 08:16:20 volumio-n1 kernel: 32regs : 2811.200 MB/sec Apr 21 08:16:20 volumio-n1 kernel: 32regs_prefetch: 2370.800 MB/sec Apr 21 08:16:20 volumio-n1 kernel: xor: using function: 32regs (2811.200 MB/sec) Apr 21 08:16:20 volumio-n1 kernel: pinctrl core: initialized pinctrl subsystem Apr 21 08:16:20 volumio-n1 kernel: regulator-dummy: no parameters Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 16 Apr 21 08:16:20 volumio-n1 kernel: cpuidle: using governor menu Apr 21 08:16:20 volumio-n1 kernel: aml_vdac_init: module init Apr 21 08:16:20 volumio-n1 kernel: register canvas platform driver Apr 21 08:16:20 volumio-n1 kernel: register rdma platform driver Apr 21 08:16:20 volumio-n1 kernel: vdso: 2 pages (1 code, 1 data) at base ffffffc00206c000 Apr 21 08:16:20 volumio-n1 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Apr 21 08:16:20 volumio-n1 kernel: DMA: preallocated 256 KiB pool for atomic allocations Apr 21 08:16:20 volumio-n1 kernel: software IO TLB [mem 0x62400000-0x62800000] (4MB) mapped at [ffffffc062400000-ffffffc0627fffff] Apr 21 08:16:20 volumio-n1 kernel: Serial: AMBA PL011 UART driver Apr 21 08:16:20 volumio-n1 kernel: aml_i2c version: 20140813 Apr 21 08:16:20 volumio-n1 kernel: i2c-core: driver [pmu4] using legacy resume method Apr 21 08:16:20 volumio-n1 kernel: codec_mm:codec_mm_module_init Apr 21 08:16:20 volumio-n1 kernel: aml_watch_point_probe, in Apr 21 08:16:20 volumio-n1 kernel: gxbb_mpll_clk: register mpll_clk_out0 success done Apr 21 08:16:20 volumio-n1 kernel: gxbb_mpll_clk: register mpll_clk_out1 success done Apr 21 08:16:20 volumio-n1 kernel: gxbb_mpll_clk: register mpll_clk_out2 success done Apr 21 08:16:20 volumio-n1 kernel: clk_sys: register PLL sys_pll success done Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ xtal ] ->clockrate: 24000000Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ 32Khz ] ->clockrate: 32000Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ clk81 ] ->clockrate: 166666666Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ fixed_pll ] ->clockrate: 2000000000Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ fclk_div2 ] ->clockrate: 1000000000Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ fclk_div3 ] ->clockrate: 666666666Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ fclk_div4 ] ->clockrate: 500000000Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ fclk_div5 ] ->clockrate: 400000000Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: [ fclk_div7 ] ->clockrate: 285714285Hz Apr 21 08:16:20 volumio-n1 kernel: gxl_clk: clock initialization complete Apr 21 08:16:20 volumio-n1 kernel: clkmsr: Gxl msr_clk_reg0=ffffff800005c75c,msr_clk_reg2=ffffff800005e764 Apr 21 08:16:20 volumio-n1 kernel: aml_iomap: amlogic iomap probe done Apr 21 08:16:20 volumio-n1 kernel: pinmux-gxl c1109880.pinmux: Init pinux probe! Apr 21 08:16:20 volumio-n1 kernel: pinmux-gxl c1109880.pinmux: Probed amlogic pinctrl driver Apr 21 08:16:20 volumio-n1 kernel: genirq: Setting trigger mode 8 for irq 241 failed (gic_set_type+0x0/0xb8) Apr 21 08:16:20 volumio-n1 kernel: genirq: Setting trigger mode 8 for irq 242 failed (gic_set_type+0x0/0xb8) Apr 21 08:16:20 volumio-n1 kernel: genirq: Setting trigger mode 8 for irq 241 failed (gic_set_type+0x0/0xb8) Apr 21 08:16:20 volumio-n1 kernel: genirq: Setting trigger mode 8 for irq 242 failed (gic_set_type+0x0/0xb8) Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - buf.opp[0].freq_hz = 100000000 Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - buf.opp[1].freq_hz = 250000000 Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - buf.opp[2].freq_hz = 500000000 Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - buf.opp[3].freq_hz = 667000000 Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - buf.opp[4].freq_hz = 1000000000 Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - buf.opp[5].freq_hz = 1200000000 Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - buf.opp[6].freq_hz = 1512000000 Apr 21 08:16:20 volumio-n1 kernel: dvfs [scpi_dvfs_get_opps] - new count 7, max_freq 1512000000 Apr 21 08:16:20 volumio-n1 kernel: codec_mm has 2 memory regions Apr 21 08:16:20 volumio-n1 kernel: codec_mm codec_mm.18: assigned reserved memory node linux,codec_mm_cma ok Apr 21 08:16:20 volumio-n1 kernel: codec_mm codec_mm.18: assigned reserved memory node linux,codec_mm_reserved ok Apr 21 08:16:20 volumio-n1 kernel: codec_mm has 2 memory regions Apr 21 08:16:20 volumio-n1 kernel: codec_mm codec_mm.18: assigned reserved memory node linux,codec_mm_cma ok Apr 21 08:16:20 volumio-n1 kernel: codec_mm codec_mm.18: assigned reserved memory node linux,codec_mm_reserved ok Apr 21 08:16:20 volumio-n1 kernel: vpu: driver version: v03 Apr 21 08:16:20 volumio-n1 kernel: vpu: load vpu_clk: 666667000Hz(7) Apr 21 08:16:20 volumio-n1 kernel: vpu: vpu_probe OK Apr 21 08:16:20 volumio-n1 kernel: tv_vout: tvout_probe Apr 21 08:16:20 volumio-n1 kernel: tv_vout: chrdev devno 266338304 for disp Apr 21 08:16:20 volumio-n1 kernel: vout_notify: vout_register_server Apr 21 08:16:20 volumio-n1 kernel: tv_vout: register tv module server ok Apr 21 08:16:20 volumio-n1 kernel: tv_vout: create cdev tv Apr 21 08:16:20 volumio-n1 kernel: tv_vout: tvout_probe OK Apr 21 08:16:20 volumio-n1 kernel: canvas_probe reg=00000000c8838000,size=400 Apr 21 08:16:20 volumio-n1 kernel: canvas maped reg_base =ffffff800007e000 Apr 21 08:16:20 volumio-n1 kernel: rdma_probe Apr 21 08:16:20 volumio-n1 kernel: bio: create slab at 0 Apr 21 08:16:20 volumio-n1 kernel: raid6: int64x1 491 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: int64x2 717 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: int64x4 1039 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: int64x8 1199 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: neonx1 767 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: neonx2 1242 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: neonx4 1596 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: neonx8 1692 MB/s Apr 21 08:16:20 volumio-n1 kernel: raid6: using algorithm neonx8 (1692 MB/s) Apr 21 08:16:20 volumio-n1 kernel: raid6: using intx1 recovery algorithm Apr 21 08:16:20 volumio-n1 kernel: SCSI subsystem initialized Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver usbfs Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver hub Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new device driver usb Apr 21 08:16:20 volumio-n1 kernel: i2c-gpio i2c_gpio.38: using pins 172 (SDA) and 173 (SCL) Apr 21 08:16:20 volumio-n1 kernel: media: Linux media interface: v0.10 Apr 21 08:16:20 volumio-n1 kernel: Linux video capture interface: v2.00 Apr 21 08:16:20 volumio-n1 kernel: pps_core: LinuxPPS API ver. 1 registered Apr 21 08:16:20 volumio-n1 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Apr 21 08:16:20 volumio-n1 kernel: PTP clock support registered Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: amhdmitx_init Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: Ver: 2014May6 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: amhdmitx_probe Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: not find match init-data Apr 21 08:16:20 volumio-n1 kernel: hdmitx hpd irq = 89 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xc0800000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xc1104400 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xc8100000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xc8834000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xc883a000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xc883c000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xd0100000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx20: Mapped PHY: 0xda83a000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: alread display in uboot 0x10 Apr 21 08:16:20 volumio-n1 kernel: avmute set to 1 Apr 21 08:16:20 volumio-n1 kernel: vout_serve: no matched vout_init mode Apr 21 08:16:20 volumio-n1 kernel: vinfo: error: invalid vinfo. current vmode is not supported Apr 21 08:16:20 volumio-n1 kernel: vout_serve: create_vout_fops OK Apr 21 08:16:20 volumio-n1 kernel: vout_serve: create vout attribute OK Apr 21 08:16:20 volumio-n1 kernel: vout_serve: meson_vout_probe OK Apr 21 08:16:20 volumio-n1 kernel: logo: logo_init Apr 21 08:16:20 volumio-n1 kernel: Advanced Linux Sound Architecture Driver Initialized. Apr 21 08:16:20 volumio-n1 kernel: Switched to clocksource arch_sys_counter Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: irq 80000002 Apr 21 08:16:20 volumio-n1 kernel: FS-Cache: Loaded Apr 21 08:16:20 volumio-n1 kernel: CacheFiles: Loaded Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 2 Apr 21 08:16:20 volumio-n1 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes) Apr 21 08:16:20 volumio-n1 kernel: TCP bind hash table entries: 16384 (order: 6, 262144 bytes) Apr 21 08:16:20 volumio-n1 kernel: TCP: Hash tables configured (established 16384 bind 16384) Apr 21 08:16:20 volumio-n1 kernel: TCP: reno registered Apr 21 08:16:20 volumio-n1 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes) Apr 21 08:16:20 volumio-n1 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes) Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 1 Apr 21 08:16:20 volumio-n1 kernel: RPC: Registered named UNIX socket transport module. Apr 21 08:16:20 volumio-n1 kernel: RPC: Registered udp transport module. Apr 21 08:16:20 volumio-n1 kernel: RPC: Registered tcp transport module. Apr 21 08:16:20 volumio-n1 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_dev_probe] no power_on_pin2 Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_dev_probe] set pwm as 32k output Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_dev_probe] dhd_static_buf setup Apr 21 08:16:20 volumio-n1 kernel: Wifi: bcmdhd_init_wlan_mem: bcmdhd_init_wlan_mem: WIFI MEM Allocated Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_dev_probe] interrupt_pin=241 Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_dev_probe] irq_num=100, irq_trigger_type=1 Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_dev_probe] power_on_pin=240 Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_dev_probe] clock_32k_pin=0 Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_setup_dt] wifi_setup_dt Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_setup_dt] interrupt_pin(241) Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [wifi_setup_dt] power_on_pin(240) Apr 21 08:16:20 volumio-n1 kernel: Unpacking initramfs... Apr 21 08:16:20 volumio-n1 kernel: Freeing initrd memory: 4468K (ffffffc073a69000 - ffffffc073ec6000) Apr 21 08:16:20 volumio-n1 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes) Apr 21 08:16:20 volumio-n1 kernel: audit: initializing netlink subsys (disabled) Apr 21 08:16:20 volumio-n1 kernel: audit: type=2000 audit(2.380:1): initialized Apr 21 08:16:20 volumio-n1 kernel: HugeTLB registered 2 MB page size, pre-allocated 0 pages Apr 21 08:16:20 volumio-n1 kernel: VFS: Disk quotas dquot_6.5.2 Apr 21 08:16:20 volumio-n1 kernel: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 21 08:16:20 volumio-n1 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 21 08:16:20 volumio-n1 kernel: NFS: Registering the id_resolver key type Apr 21 08:16:20 volumio-n1 kernel: Key type id_resolver registered Apr 21 08:16:20 volumio-n1 kernel: Key type id_legacy registered Apr 21 08:16:20 volumio-n1 kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Apr 21 08:16:20 volumio-n1 kernel: jffs2: version 2.2. (NAND) © 2001-2006 Red Hat, Inc. Apr 21 08:16:20 volumio-n1 kernel: ROMFS MTD (C) 2007 Red Hat, Inc. Apr 21 08:16:20 volumio-n1 kernel: fuse init (API version 7.22) Apr 21 08:16:20 volumio-n1 kernel: msgmni has been set to 3596 Apr 21 08:16:20 volumio-n1 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245) Apr 21 08:16:20 volumio-n1 kernel: io scheduler noop registered (default) Apr 21 08:16:20 volumio-n1 kernel: io scheduler deadline registered Apr 21 08:16:20 volumio-n1 kernel: io scheduler cfq registered Apr 21 08:16:20 volumio-n1 kernel: hdmitx: plugin Apr 21 08:16:20 volumio-n1 kernel: EDID Parser: Apr 21 08:16:20 volumio-n1 kernel: hdmitx: get dtd0 vic: 16 Apr 21 08:16:20 volumio-n1 kernel: dump_dtd_info[1762] Apr 21 08:16:20 volumio-n1 kernel: pixel_clock 7950 Apr 21 08:16:20 volumio-n1 kernel: h_active 1280 Apr 21 08:16:20 volumio-n1 kernel: h_blank 384 Apr 21 08:16:20 volumio-n1 kernel: v_active 768 Apr 21 08:16:20 volumio-n1 kernel: v_blank 30 Apr 21 08:16:20 volumio-n1 kernel: h_sync_offset 48 Apr 21 08:16:20 volumio-n1 kernel: h_sync 32 Apr 21 08:16:20 volumio-n1 kernel: v_sync_offset 3 Apr 21 08:16:20 volumio-n1 kernel: v_sync 7 Apr 21 08:16:20 volumio-n1 kernel: dump_dtd_info[1762] Apr 21 08:16:20 volumio-n1 kernel: pixel_clock 8550 Apr 21 08:16:20 volumio-n1 kernel: h_active 1366 Apr 21 08:16:20 volumio-n1 kernel: h_blank 426 Apr 21 08:16:20 volumio-n1 kernel: v_active 768 Apr 21 08:16:20 volumio-n1 kernel: v_blank 30 Apr 21 08:16:20 volumio-n1 kernel: h_sync_offset 70 Apr 21 08:16:20 volumio-n1 kernel: h_sync 143 Apr 21 08:16:20 volumio-n1 kernel: v_sync_offset 3 Apr 21 08:16:20 volumio-n1 kernel: v_sync 3 Apr 21 08:16:20 volumio-n1 kernel: dump_dtd_info[1762] Apr 21 08:16:20 volumio-n1 kernel: pixel_clock 18559 Apr 21 08:16:20 volumio-n1 kernel: h_active 1920 Apr 21 08:16:20 volumio-n1 kernel: h_blank 280 Apr 21 08:16:20 volumio-n1 kernel: v_active 1080 Apr 21 08:16:20 volumio-n1 kernel: v_blank 45 Apr 21 08:16:20 volumio-n1 kernel: h_sync_offset 48 Apr 21 08:16:20 volumio-n1 kernel: h_sync 40 Apr 21 08:16:20 volumio-n1 kernel: v_sync_offset 5 Apr 21 08:16:20 volumio-n1 kernel: v_sync 5 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: find IEEEOUT Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: vinfo: error: invalid vinfo. current vmode is not supported Apr 21 08:16:20 volumio-n1 kernel: hdmitx: update RX hdr info 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: blk0 raw data Apr 21 08:16:20 volumio-n1 kernel: 00ffffffffffff0035ee0027110100001c1d0103803c2178ea2d36a75438ae26 0d4f54bfcf0081c0b30095008180a9c081007140814f023a801871382d40582c 450055502100001a0e1f008051001e303020370070cf1000001c662156aa5100 1e30468f330099e61000001c000000fc004e3730300a202020202020202001fb Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: blk1 raw data Apr 21 08:16:20 volumio-n1 kernel: 02031cf148901f051404130312230907078301000066030c001000807f488018 71382d4030285500a05a0000001e000000000000000000000000000000000000 0000000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000b5 Apr 21 08:16:20 volumio-n1 kernel: [RX]-receive ksv list len:1,depth:1,cas:0,dev:0 Apr 21 08:16:20 volumio-n1 kernel: vinfo: error: invalid vinfo. current vmode is not supported Apr 21 08:16:20 volumio-n1 kernel: hdmitx: video: get current mode: invalid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: update rx hdr info 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: update physcial size: 600 330 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: not find mapped vic Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: already init VIC = 0 Now VIC = 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: packet: can't get vendor data Apr 21 08:16:20 volumio-n1 kernel: invalid 60 1 Apr 21 08:16:20 volumio-n1 kernel: invalid 60 1 Apr 21 08:16:20 volumio-n1 kernel: hdmtix: set audio Apr 21 08:16:20 volumio-n1 kernel: hdmitx tx_aud_src = 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: fs = 0, cd = 4, tmds_clk = 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx aud_n_para = 6144 Apr 21 08:16:20 volumio-n1 kernel: hdmitx set channel status Apr 21 08:16:20 volumio-n1 kernel: hdmtix: set audio Apr 21 08:16:20 volumio-n1 kernel: hdmitx tx_aud_src = 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: fs = 0, cd = 4, tmds_clk = 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx aud_n_para = 6144 Apr 21 08:16:20 volumio-n1 kernel: hdmitx set channel status Apr 21 08:16:20 volumio-n1 kernel: meson-rng c8834000.rng: hwrng registered Apr 21 08:16:20 volumio-n1 kernel: [drm] Initialized drm 1.1.0 20060810 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: max pp is 3 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: set min pp to default 1 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: min pp is 1 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: set min clk default to 0 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: min clk is 0 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: hiu io source 0xffffff80001de000 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: hiu io source 0xffffff80001fe000 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: num of pp used most of time 3 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: clock dvfs table size is 7 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: max clk set 5 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: max clk is 5 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: turbo clk set to 6 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: turbo clk is 6 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: default clk is 3 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: ====================0==================== clk_freq= 125000000, clk_parent=fclk_div4, voltage=1150, keep_count=5, threshod=<30 250>, clk_sample=125 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: ====================1==================== clk_freq= 285000000, clk_parent=fclk_div7, voltage=1150, keep_count=5, threshod=<100 250>, clk_sample=285 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: ====================2==================== clk_freq= 400000000, clk_parent=fclk_div5, voltage=1150, keep_count=3, threshod=<168 250>, clk_sample=400 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: ====================3==================== clk_freq= 500000000, clk_parent=fclk_div4, voltage=1150, keep_count=2, threshod=<190 250>, clk_sample=500 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: ====================4==================== clk_freq= 666000000, clk_parent=fclk_div3, voltage=1150, keep_count=1, threshod=<177 250>, clk_sample=666 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: ====================5==================== clk_freq= 744000000, clk_parent= gp0_pll, voltage=1150, keep_count=1, threshod=<213 255>, clk_sample=744 Apr 21 08:16:20 volumio-n1 kernel: mali-utgard d00c0000.mali: ====================6==================== clk_freq= 744000000, clk_parent= gp0_pll, voltage=1150, keep_count=1, threshod=<213 255>, clk_sample=744 Apr 21 08:16:20 volumio-n1 kernel: gpu cooling register okay with err=0 Apr 21 08:16:20 volumio-n1 kernel: gpu core cooling register okay with err=0 Apr 21 08:16:20 volumio-n1 kernel: Mali: Mali device driver loaded Apr 21 08:16:20 volumio-n1 kernel: UMP: UMP device driver -f29b82a loaded Apr 21 08:16:20 volumio-n1 kernel: loop: module loaded Apr 21 08:16:20 volumio-n1 kernel: mtdoops: mtd device (mtddev=name/number) must be supplied Apr 21 08:16:20 volumio-n1 kernel: tun: Universal TUN/TAP device driver, 1.6 Apr 21 08:16:20 volumio-n1 kernel: tun: (C) 1999-2004 Max Krasnyansky Apr 21 08:16:20 volumio-n1 kernel: libphy: stmmac: probed Apr 21 08:16:20 volumio-n1 kernel: eth0: PHY ID 001cc916 at 0 IRQ POLL (stmmac-0:00) active Apr 21 08:16:20 volumio-n1 kernel: eth0: PHY ID 001cc916 at 7 IRQ POLL (stmmac-0:07) Apr 21 08:16:20 volumio-n1 kernel: PPP generic driver version 2.4.2 Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 24 Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver cdc_ether Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver cdc_ncm Apr 21 08:16:20 volumio-n1 kernel: platform c9000000.dwc3: Driver dwc3 requests probe deferral Apr 21 08:16:20 volumio-n1 kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Apr 21 08:16:20 volumio-n1 kernel: ehci-h20ahb: H20AHB-EHCI Host Controller driver Apr 21 08:16:20 volumio-n1 kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver cdc_acm Apr 21 08:16:20 volumio-n1 kernel: cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver usb-storage Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver usbserial Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver usbserial_generic Apr 21 08:16:20 volumio-n1 kernel: usbserial: USB Serial support registered for generic Apr 21 08:16:20 volumio-n1 kernel: amlogic-new-usb2 d0078000.usb2phy: USB2 phy probe:phy_mem:0xd0078000, iomap phy_base:0xffffff8000592000 Apr 21 08:16:20 volumio-n1 kernel: amlogic-new-usb3 d0078080.usb3phy: This phy has no usb port Apr 21 08:16:20 volumio-n1 kernel: amlogic-new-usb3 d0078080.usb3phy: USB3 phy probe:phy_mem:0xd0078080, iomap phy_base:0xffffff8000594080 Apr 21 08:16:20 volumio-n1 kernel: mousedev: PS/2 mouse device common for all mice Apr 21 08:16:20 volumio-n1 kernel: i2c /dev entries driver Apr 21 08:16:20 volumio-n1 kernel: CPUidle arm64: cpuidle init start!! Apr 21 08:16:20 volumio-n1 kernel: CPUidle arm64: cpuidle init done! Apr 21 08:16:20 volumio-n1 kernel: ledtrig-cpu: registered to indicate activity on CPUs Apr 21 08:16:20 volumio-n1 kernel: hidraw: raw HID events driver (C) Jiri Kosina Apr 21 08:16:20 volumio-n1 kernel: usbcore: registered new interface driver usbhid Apr 21 08:16:20 volumio-n1 kernel: usbhid: USB HID core driver Apr 21 08:16:20 volumio-n1 kernel: meson_uart c81004c0.serial: ==uart0 reg addr = ffffff80005964c0 Apr 21 08:16:20 volumio-n1 kernel: c81004c0.serial: ttyS0 at MMIO 0xc81004c0 (irq = 225, base_baud = 1500000) is a meson_uart Apr 21 08:16:20 volumio-n1 kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 0 to 115200 Apr 21 08:16:20 volumio-n1 kernel: console [ttyS0] enabled Apr 21 08:16:20 volumio-n1 kernel: meson_uart c11084c0.serial: ==uart1 reg addr = ffffff80005984c0 Apr 21 08:16:20 volumio-n1 kernel: c11084c0.serial: ttyS1 at MMIO 0xc11084c0 (irq = 58, base_baud = 1500000) is a meson_uart Apr 21 08:16:20 volumio-n1 kernel: dwc_otg: usb0: type: 2 speed: 0, config: 0, dma: 0, id: 0, phy: d0078000, ctrl: 0 Apr 21 08:16:20 volumio-n1 kernel: dwc_otg_driver_probe host only, not probe usb_otg!!! Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: hdmitx_hdcp_init Apr 21 08:16:20 volumio-n1 kernel: aml_vrtc rtc.32: rtc core: registered aml_vrtc as rtc0 Apr 21 08:16:20 volumio-n1 kernel: BLASTER Driver Init Apr 21 08:16:20 volumio-n1 kernel: secmon has 1 memory regions Apr 21 08:16:20 volumio-n1 kernel: secmon: share in base: 0xffffff80005d4000, share out base: 0xffffff80005d6000 Apr 21 08:16:20 volumio-n1 kernel: secmon secmon.4: assigned reserved memory node linux,secmon ok Apr 21 08:16:20 volumio-n1 kernel: secmon: probe done Apr 21 08:16:20 volumio-n1 kernel: storage: storage in base: 0xffffff8001600000 Apr 21 08:16:20 volumio-n1 kernel: storage: storage out base: 0xffffff8001680000 Apr 21 08:16:20 volumio-n1 kernel: storage: storage block base: 0xffffff8001700000 Apr 21 08:16:20 volumio-n1 kernel: storage: probe done! Apr 21 08:16:20 volumio-n1 kernel: Error: Driver 'ICPlus IP175C' is already registered, aborting... Apr 21 08:16:20 volumio-n1 kernel: libphy: ICPlus IP175C: Error -16 in registering driver Apr 21 08:16:20 volumio-n1 kernel: Error: Driver 'AMLOGIC internal phy' is already registered, aborting... Apr 21 08:16:20 volumio-n1 kernel: libphy: AMLOGIC internal phy: Error -16 in registering driver Apr 21 08:16:20 volumio-n1 kernel: Error: Driver 'RTL8211F Gigabit Ethernet' is already registered, aborting... Apr 21 08:16:20 volumio-n1 kernel: libphy: RTL8211F Gigabit Ethernet: Error -16 in registering driver Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_probe: line 3594 Apr 21 08:16:20 volumio-n1 kernel: mmc driver version: 1.07, 2015-01-21: fix a bug in tuning which caused eMMC data CRC error Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_reg_init 1149 Apr 21 08:16:20 volumio-n1 kernel: get property: ocr_avail, value:0x00200080 Apr 21 08:16:20 volumio-n1 kernel: get property: f_min, value:300000 Apr 21 08:16:20 volumio-n1 kernel: get property: f_max, value:100000000 Apr 21 08:16:20 volumio-n1 kernel: get property: max_req_size, value:0x00020000 Apr 21 08:16:20 volumio-n1 kernel: get property: pinname, str:emmc Apr 21 08:16:20 volumio-n1 kernel: get property: card_type, value:1 Apr 21 08:16:20 volumio-n1 kernel: get property: gpio_dat3, str: Apr 21 08:16:20 volumio-n1 kernel: get property: hw_reset, str: Apr 21 08:16:20 volumio-n1 kernel: emmc:pdata->caps = c0000d47 Apr 21 08:16:20 volumio-n1 kernel: emmc:pdata->caps2 = 18060 Apr 21 08:16:20 volumio-n1 kernel: emmc:pdata->pm_caps = 0 Apr 21 08:16:20 volumio-n1 kernel: storage 1, boot 1 Apr 21 08:16:20 volumio-n1 kernel: get_storage_dev return 1 Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_probe] aml_sd_emmc_probe() success! Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_probe: line 3594 Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_reg_init 1149 Apr 21 08:16:20 volumio-n1 kernel: get property: ocr_avail, value:0x00200080 Apr 21 08:16:20 volumio-n1 kernel: get property: f_min, value:400000 Apr 21 08:16:20 volumio-n1 kernel: get property: f_max, value:100000000 Apr 21 08:16:20 volumio-n1 kernel: get property: max_req_size, value:0x00020000 Apr 21 08:16:20 volumio-n1 kernel: get property: irq_in, value:3 Apr 21 08:16:20 volumio-n1 kernel: get property: irq_out, value:5 Apr 21 08:16:20 volumio-n1 kernel: get property: gpio_cd, str: Apr 21 08:16:20 volumio-n1 kernel: get property: pinname, str:sd Apr 21 08:16:20 volumio-n1 kernel: get property: jtag_pin, str: Apr 21 08:16:20 volumio-n1 kernel: get property: card_type, value:5 Apr 21 08:16:20 volumio-n1 kernel: get property: gpio_dat3, str: Apr 21 08:16:20 volumio-n1 kernel: sd:pdata->caps = 7 Apr 21 08:16:20 volumio-n1 kernel: sd:pdata->caps2 = 0 Apr 21 08:16:20 volumio-n1 kernel: sd:pdata->pm_caps = 0 Apr 21 08:16:20 volumio-n1 kernel: [aml_is_card_insert] card OUT Apr 21 08:16:20 volumio-n1 kernel: [aml_is_card_insert] card OUT Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_probe] aml_sd_emmc_probe() success! Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_probe: line 3594 Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_reg_init 1149 Apr 21 08:16:20 volumio-n1 kernel: get property: ocr_avail, value:0x00200080 Apr 21 08:16:20 volumio-n1 kernel: get property: f_min, value:400000 Apr 21 08:16:20 volumio-n1 kernel: emmc: BKOPS_EN bit is not set Apr 21 08:16:20 volumio-n1 kernel: emmc: trying cali 0-th time(s) Apr 21 08:16:20 volumio-n1 kernel: get property: f_max, value:200000000 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[0]= 4200 padding= 4, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[1]= 4600 padding= 2, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[2]= 4200 padding= 4, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[3]= 4400 padding= 3, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[4]= 4600 padding= 2, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[5]= 4400 padding= 3, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[6]= 4600 padding= 2, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: delay[7]= 4400 padding= 3, bidx=4 Apr 21 08:16:20 volumio-n1 kernel: emmc: calibration result @ 0: max(4600), min(4200) Apr 21 08:16:20 volumio-n1 kernel: emmc: line_delay =0x10101202, max_cal_result =4600 Apr 21 08:16:20 volumio-n1 kernel: emmc: base_index_max 4, base_index_min 4 Apr 21 08:16:20 volumio-n1 kernel: emmc: clk 100000000 SDR mode tuning start Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[0] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[1] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[2] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[3] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[4] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[5] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[6] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[7] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: rx_tuning_result[9] = 10 Apr 21 08:16:20 volumio-n1 kernel: emmc: best_win_start =9, best_win_size =9 Apr 21 08:16:20 volumio-n1 kernel: emmc: sd_emmc_regs->gclock=0x100024a,sd_emmc_regs->gadjust=0x32000 Apr 21 08:16:20 volumio-n1 kernel: emmc: gclock =0x100024a, gdelay=0x10101202, gadjust=0x32000 Apr 21 08:16:20 volumio-n1 kernel: emmc: support driver strength type 1 Apr 21 08:16:20 volumio-n1 kernel: emmc: try set sd/emmc to DDR mode Apr 21 08:16:20 volumio-n1 kernel: emmc: try set sd/emmc to DDR mode Apr 21 08:16:20 volumio-n1 kernel: emmc: new HS400 MMC card at address 0001 Apr 21 08:16:20 volumio-n1 kernel: emmc: clock 100000000, 8-bit-bus-width Apr 21 08:16:20 volumio-n1 kernel: mmcblk0: emmc:0001 8GME4R 7.28 GiB Apr 21 08:16:20 volumio-n1 kernel: mmcblk0boot0: emmc:0001 8GME4R partition 1 4.00 MiB Apr 21 08:16:20 volumio-n1 kernel: mmcblk0boot1: emmc:0001 8GME4R partition 2 4.00 MiB Apr 21 08:16:20 volumio-n1 kernel: mmcblk0rpmb: emmc:0001 8GME4R partition 3 512 KiB Apr 21 08:16:20 volumio-n1 kernel: get property: max_req_size, value:0x00020000 Apr 21 08:16:20 volumio-n1 kernel: mmcblk0: unknown partition table Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_irq] emmc: warning... response crc,vstat:0xa1ff2400,virqc:3fff Apr 21 08:16:20 volumio-n1 kernel: [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 Apr 21 08:16:20 volumio-n1 kernel: [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x12000, operation is in [reserved] disk! Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_data_thread 2639 emmc: cmd:18 Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2655: set 1st retry! Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_data_thread] cmd_delay change to 2 Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xa1ff2800,virqc:3fff Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_data_thread : 2586 Apr 21 08:16:20 volumio-n1 kernel: [mmc_read_partition_tbl] mmc read partition OK! Apr 21 08:16:20 volumio-n1 kernel: add_emmc_partition Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p01] bootloader offset 0x000000000000, size 0x000000400000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p02] reserved offset 0x000002400000, size 0x000004000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p03] cache offset 0x000006c00000, size 0x000020000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p04] env offset 0x000027400000, size 0x000000800000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p05] logo offset 0x000028400000, size 0x000002000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p06] recovery offset 0x00002ac00000, size 0x000002000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p07] rsv offset 0x00002d400000, size 0x000000800000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p08] tee offset 0x00002e400000, size 0x000000800000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p09] crypt offset 0x00002f400000, size 0x000002000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p10] misc offset 0x000031c00000, size 0x000002000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p11] boot offset 0x000034400000, size 0x000002000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p12] system offset 0x000036c00000, size 0x000050000000 Apr 21 08:16:20 volumio-n1 kernel: [mmcblk0p13] data offset 0x000087400000, size 0x00014ac00000 Apr 21 08:16:20 volumio-n1 kernel: card key: card_blk_probe. Apr 21 08:16:20 volumio-n1 kernel: emmc_key_init:527 emmc key lba_start:0x12020,lba_end:0x12220 Apr 21 08:16:20 volumio-n1 kernel: emmc key: emmc_key_init:552 ok. Apr 21 08:16:20 volumio-n1 kernel: amlmmc_dtb_init: register dtb chardev Apr 21 08:16:20 volumio-n1 kernel: calc 39b2412, store 39b2412 Apr 21 08:16:20 volumio-n1 kernel: calc 39b2412, store 39b2412 Apr 21 08:16:20 volumio-n1 kernel: total valid 2 Apr 21 08:16:20 volumio-n1 kernel: amlmmc_dtb_init: register dtb chardev OK Apr 21 08:16:20 volumio-n1 kernel: Exit aml_emmc_partition_ops OK. Apr 21 08:16:20 volumio-n1 kernel: mmcblk0boot1: unknown partition table Apr 21 08:16:20 volumio-n1 kernel: mmcblk0boot0: unknown partition table Apr 21 08:16:20 volumio-n1 kernel: clear_emmc_wait_flag Apr 21 08:16:20 volumio-n1 kernel: get property: pinname, str:sdio Apr 21 08:16:20 volumio-n1 kernel: get property: card_type, value:3 Apr 21 08:16:20 volumio-n1 kernel: sdio:pdata->caps = 7810f Apr 21 08:16:20 volumio-n1 kernel: sdio:pdata->caps2 = 0 Apr 21 08:16:20 volumio-n1 kernel: sdio:pdata->pm_caps = 1 Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_probe] aml_sd_emmc_probe() success! Apr 21 08:16:20 volumio-n1 kernel: ion_dev has 1 memory regions Apr 21 08:16:20 volumio-n1 kernel: fb: osd_init_module Apr 21 08:16:20 volumio-n1 kernel: fb: viu vsync irq: 35 Apr 21 08:16:20 volumio-n1 kernel: meson-fb has 1 memory regions Apr 21 08:16:20 volumio-n1 kernel: meson-fb meson-fb.15: assigned reserved memory node linux,meson-fb ok Apr 21 08:16:20 volumio-n1 kernel: tv_vout: tv_set_current_vmode[919]fps_target_mode=16 Apr 21 08:16:20 volumio-n1 kernel: tv_vout: mode is 16,sync_duration_den=1,sync_duration_num=60 Apr 21 08:16:20 volumio-n1 kernel: tv_vout: TV mode 1080p60hz selected. Apr 21 08:16:20 volumio-n1 kernel: vdac_enable: on:0,module_sel:8 Apr 21 08:16:20 volumio-n1 kernel: vdac_enable: on:0,module_sel:8 Apr 21 08:16:20 volumio-n1 kernel: tv_vout: new mode =1080p60hz set ok Apr 21 08:16:20 volumio-n1 kernel: vout_serve: vinfo mode is: 1080p60hz Apr 21 08:16:20 volumio-n1 kernel: osd_rdma: osd_rdma_init: rdma_table p=0x67045000,op=0x67045000 , v=0xffffff80005fa000 Apr 21 08:16:20 volumio-n1 kernel: rdma_register, rdma_table_addr ffffff80005fc000 rdma_table_addr_phy 6704c000 reg_buf ffffffc062b59000 Apr 21 08:16:20 volumio-n1 kernel: rdma_register success, handle 1 table_size 4096 Apr 21 08:16:20 volumio-n1 kernel: osd_rdma: osd_rdma_init:osd reset rdma handle = 1. Apr 21 08:16:20 volumio-n1 kernel: rdma_register, rdma_table_addr ffffff80005fe000 rdma_table_addr_phy 6704d000 reg_buf ffffffc061da9000 Apr 21 08:16:20 volumio-n1 kernel: rdma_register success, handle 2 table_size 4096 Apr 21 08:16:20 volumio-n1 kernel: osd_rdma: osd_rdma_init:osd rdma handle = 2. Apr 21 08:16:20 volumio-n1 kernel: fb: osd_probe vinfo:ffffffc0020f2870 Apr 21 08:16:20 volumio-n1 kernel: fb: init fbdev bpp is:32 Apr 21 08:16:20 volumio-n1 kernel: fb: Frame buffer memory assigned at Apr 21 08:16:20 volumio-n1 kernel: fb: 0, phy: 0x000000007d100000, vir:0xffffff8001900000, size=24576K Apr 21 08:16:20 volumio-n1 kernel: fb: ---------------clear fb0 memory ffffff8001900000 Apr 21 08:16:20 volumio-n1 kernel: fb: osd[0] canvas.idx =0x40 Apr 21 08:16:20 volumio-n1 kernel: fb: osd[0] canvas.addr=0x7d100000 Apr 21 08:16:20 volumio-n1 kernel: fb: osd[0] canvas.width=7680 Apr 21 08:16:20 volumio-n1 kernel: fb: osd[0] canvas.height=3240 Apr 21 08:16:20 volumio-n1 kernel: fb: osd[0] frame.width=1920 Apr 21 08:16:20 volumio-n1 kernel: fb: osd[0] frame.height=1080 Apr 21 08:16:20 volumio-n1 kernel: Console: switching to colour frame buffer device 240x67 Apr 21 08:16:20 volumio-n1 kernel: fb: set osd0 reverse as NONE Apr 21 08:16:20 volumio-n1 kernel: fb: osd probe OK Apr 21 08:16:20 volumio-n1 kernel: ge2d: ge2d_init_module Apr 21 08:16:20 volumio-n1 kernel: ge2d: ge2d_dev major:238 Apr 21 08:16:20 volumio-n1 kernel: ge2d: ge2d clock is 400 MHZ Apr 21 08:16:20 volumio-n1 kernel: ge2d: ge2d: pdev=ffffffc0628e4800, irq=182, rstc=0xffffffc061c58900, clk=ffffffc0001bcd00 Apr 21 08:16:20 volumio-n1 kernel: ge2d: mapped phy: 0xd0160000 Apr 21 08:16:20 volumio-n1 kernel: ge2d: ge2d start monitor Apr 21 08:16:20 volumio-n1 kernel: ge2d: ge2d workqueue monitor start Apr 21 08:16:20 volumio-n1 kernel: codec:Amlogic A/V streaming port init Apr 21 08:16:20 volumio-n1 kernel: codec:get gate demux control ok ffffffc062892380 Apr 21 08:16:20 volumio-n1 kernel: codec:get gate parser_top control ok ffffffc062892840 Apr 21 08:16:20 volumio-n1 kernel: codec:get gate vpu_intr control ok ffffffc062892400 Apr 21 08:16:20 volumio-n1 kernel: codec:get gate vdec control ok ffffffc062892880 Apr 21 08:16:20 volumio-n1 kernel: codec:[tsync_pcr_init]init success. Apr 21 08:16:20 volumio-n1 kernel: codec:amvideocap_probe,amvideocap Apr 21 08:16:20 volumio-n1 kernel: codec:use cma buf. Apr 21 08:16:20 volumio-n1 kernel: amvenc_avc_probe -- reserved memory config fail. Apr 21 08:16:20 volumio-n1 kernel: amvenc_avc - cma memory pool size: 40 MB Apr 21 08:16:20 volumio-n1 kernel: encode_wq_init. Apr 21 08:16:20 volumio-n1 kernel: encode start monitor. Apr 21 08:16:20 volumio-n1 kernel: encode workqueue monitor start. Apr 21 08:16:20 volumio-n1 kernel: jpegenc module init Apr 21 08:16:20 volumio-n1 kernel: codec:picdec_driver_probe called. Apr 21 08:16:20 volumio-n1 kernel: picdec has 1 memory regions Apr 21 08:16:20 volumio-n1 kernel: codec:picdec_driver_probe done. Apr 21 08:16:20 volumio-n1 kernel: codec:vdec_request_irq ffffffc00184fe50, vsync Apr 21 08:16:20 volumio-n1 kernel: codec:create_ge2d_work_queue video task ok Apr 21 08:16:20 volumio-n1 kernel: rdma_register, rdma_table_addr ffffff8000742000 rdma_table_addr_phy 67058000 reg_buf ffffffc061e38000 Apr 21 08:16:20 volumio-n1 kernel: rdma_register success, handle 3 table_size 32768 Apr 21 08:16:20 volumio-n1 kernel: video_rdma:rdma_init video rdma handle = 3. Apr 21 08:16:20 volumio-n1 kernel: codec:used fix clk for vdec clk source! Apr 21 08:16:20 volumio-n1 kernel: codec:register clk_set_setting cpu[33] Apr 21 08:16:20 volumio-n1 kernel: vpu_init Apr 21 08:16:20 volumio-n1 kernel: The chip is not support hevc encoder Apr 21 08:16:20 volumio-n1 kernel: DI: di_module_init ok. Apr 21 08:16:20 volumio-n1 kernel: DI: di_module_init: major 232 Apr 21 08:16:20 volumio-n1 kernel: DI: di_probe Apr 21 08:16:20 volumio-n1 kernel: deinterlace has 1 memory regions Apr 21 08:16:20 volumio-n1 kernel: DI: di reveser memory 0x7b300000, size 30MB. Apr 21 08:16:20 volumio-n1 kernel: deinterlace deinterlace.25: assigned reserved memory node linux,di ok Apr 21 08:16:20 volumio-n1 kernel: DI-di_probe: get flag_cma error. Apr 21 08:16:20 volumio-n1 kernel: di_irq:78,timerc_irq:38 Apr 21 08:16:20 volumio-n1 kernel: rdma_register, rdma_table_addr ffffff800074b000 rdma_table_addr_phy 6704e000 reg_buf ffffffc062b40000 Apr 21 08:16:20 volumio-n1 kernel: rdma_register success, handle 4 table_size 8192 Apr 21 08:16:20 volumio-n1 kernel: DI: di_probe allocate rdma channel 4. Apr 21 08:16:20 volumio-n1 kernel: DI: DI hw version 2. Apr 21 08:16:20 volumio-n1 kernel: 0x000000db:Y=db,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000dc:Y=dc,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000dd:Y=dd,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000de:Y=de,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000df:Y=df,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000e0:Y=e0,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000e1:Y=e1,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000e2:Y=e2,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000e3:Y=e3,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f0:Y=f0,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f1:Y=f1,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f2:Y=f2,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f3:Y=f3,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f4:Y=f4,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f5:Y=f5,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f6:Y=f6,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f7:Y=f7,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: irq 80000004 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: plugout Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: unmux DDC for gpio read edid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: clear RX hdr info Apr 21 08:16:20 volumio-n1 kernel: 0x000000f8:Y=f8,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000f9:Y=f9,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000fa:Y=fa,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000fb:Y=fb,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: 0x000000fc:Y=fc,U=0,V=0 Apr 21 08:16:20 volumio-n1 kernel: efusekeynum: 4 Apr 21 08:16:20 volumio-n1 kernel: efusekeyname: mac offset: 0 size: 6 Apr 21 08:16:20 volumio-n1 kernel: efusekeyname: mac_bt offset: 6 size: 6 Apr 21 08:16:20 volumio-n1 kernel: efusekeyname: mac_wifi offset: 12 size: 6 Apr 21 08:16:20 volumio-n1 kernel: efusekeyname: usid offset: 18 size: 16 Apr 21 08:16:20 volumio-n1 kernel: efuse efuse.9: probe OK! Apr 21 08:16:20 volumio-n1 kernel: key unify config unifykey-num is 14 Apr 21 08:16:20 volumio-n1 kernel: key unify fact unifykey-num is 14 Apr 21 08:16:20 volumio-n1 kernel: aml_unifykeys_probe:1280=============unifykey_devno:e600000 Apr 21 08:16:20 volumio-n1 kernel: [39B blob data] Apr 21 08:16:20 volumio-n1 kernel: [26B blob data] Apr 21 08:16:20 volumio-n1 kernel: PPMGRDRV: warn: ppmgr module init func called Apr 21 08:16:20 volumio-n1 kernel: PPMGRDRV: err: ppmgr_driver_probe called Apr 21 08:16:20 volumio-n1 kernel: ppmgr has 1 memory regions Apr 21 08:16:20 volumio-n1 kernel: PPMGRDRV: info: ppmgr_dev major:229 Apr 21 08:16:20 volumio-n1 kernel: PPMGRDRV: info: ppmgr_probe done Apr 21 08:16:20 volumio-n1 kernel: amlogic rfkill init Apr 21 08:16:20 volumio-n1 kernel: enter bt_probe of_node Apr 21 08:16:20 volumio-n1 kernel: not get gpio_en Apr 21 08:16:20 volumio-n1 kernel: power on valid level is high Apr 21 08:16:20 volumio-n1 kernel: bt: power_on_pin_OD = 0; Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: irq 80000002 Apr 21 08:16:20 volumio-n1 kernel: audio_dsp: [dsp]register dsp to char divece(257) Apr 21 08:16:20 volumio-n1 kernel: amaudio: amaudio: driver amaudio succuess! Apr 21 08:16:20 volumio-n1 kernel: amlvid:err: amlvideo_init called Apr 21 08:16:20 volumio-n1 kernel: amlvid:err: amlvideo_create_instance called Apr 21 08:16:20 volumio-n1 kernel: amlvid:err: v4l2_dev.name=:amlvideo-000 Apr 21 08:16:20 volumio-n1 kernel: amlvideo-000: V4L2 device registered as video10 Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_init: major 228 Apr 21 08:16:20 volumio-n1 kernel: rdma_register, rdma_table_addr ffffff800074e000 rdma_table_addr_phy 67051000 reg_buf ffffffc062205e00 Apr 21 08:16:20 volumio-n1 kernel: rdma_register success, handle 5 table_size 512 Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe:vdin.0 rdma hanld 5. Apr 21 08:16:20 volumio-n1 kernel: vdin memory resource undefined!! Apr 21 08:16:20 volumio-n1 kernel: vdin0 cma_mem_size = 16 MB Apr 21 08:16:20 volumio-n1 kernel: vdin0 irq: 115 rdma irq: 2 Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe: fclk_div5 is 400 MHZ Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe: vdin[0] clock is 50 MHZ Apr 21 08:16:20 volumio-n1 kernel: hdmitx: plugin Apr 21 08:16:20 volumio-n1 kernel: EDID Parser: Apr 21 08:16:20 volumio-n1 kernel: hdmitx: get dtd0 vic: 16 Apr 21 08:16:20 volumio-n1 kernel: dump_dtd_info[1762] Apr 21 08:16:20 volumio-n1 kernel: pixel_clock 7950 Apr 21 08:16:20 volumio-n1 kernel: h_active 1280 Apr 21 08:16:20 volumio-n1 kernel: h_blank 384 Apr 21 08:16:20 volumio-n1 kernel: v_active 768 Apr 21 08:16:20 volumio-n1 kernel: v_blank 30 Apr 21 08:16:20 volumio-n1 kernel: h_sync_offset 48 Apr 21 08:16:20 volumio-n1 kernel: h_sync 32 Apr 21 08:16:20 volumio-n1 kernel: v_sync_offset 3 Apr 21 08:16:20 volumio-n1 kernel: v_sync 7 Apr 21 08:16:20 volumio-n1 kernel: dump_dtd_info[1762] Apr 21 08:16:20 volumio-n1 kernel: pixel_clock 8550 Apr 21 08:16:20 volumio-n1 kernel: h_active 1366 Apr 21 08:16:20 volumio-n1 kernel: h_blank 426 Apr 21 08:16:20 volumio-n1 kernel: v_active 768 Apr 21 08:16:20 volumio-n1 kernel: v_blank 30 Apr 21 08:16:20 volumio-n1 kernel: h_sync_offset 70 Apr 21 08:16:20 volumio-n1 kernel: h_sync 143 Apr 21 08:16:20 volumio-n1 kernel: v_sync_offset 3 Apr 21 08:16:20 volumio-n1 kernel: v_sync 3 Apr 21 08:16:20 volumio-n1 kernel: dump_dtd_info[1762] Apr 21 08:16:20 volumio-n1 kernel: pixel_clock 18559 Apr 21 08:16:20 volumio-n1 kernel: h_active 1920 Apr 21 08:16:20 volumio-n1 kernel: h_blank 280 Apr 21 08:16:20 volumio-n1 kernel: v_active 1080 Apr 21 08:16:20 volumio-n1 kernel: v_blank 45 Apr 21 08:16:20 volumio-n1 kernel: h_sync_offset 48 Apr 21 08:16:20 volumio-n1 kernel: h_sync 40 Apr 21 08:16:20 volumio-n1 kernel: v_sync_offset 5 Apr 21 08:16:20 volumio-n1 kernel: v_sync 5 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: find IEEEOUT Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: update RX hdr info 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: check sum valid Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: blk0 raw data Apr 21 08:16:20 volumio-n1 kernel: 00ffffffffffff0035ee0027110100001c1d0103803c2178ea2d36a75438ae26 0d4f54bfcf0081c0b30095008180a9c081007140814f023a801871382d40582c 450055502100001a0e1f008051001e303020370070cf1000001c662156aa5100 1e30468f330099e61000001c000000fc004e3730300a202020202020202001fb Apr 21 08:16:20 volumio-n1 kernel: hdmitx: edid: blk1 raw data Apr 21 08:16:20 volumio-n1 kernel: 02031cf148901f051404130312230907078301000066030c001000807f488018 71382d4030285500a05a0000001e000000000000000000000000000000000000 0000000000000000000000000000000000000000000000000000000000000000 00000000000000000000000000000000000000000000000000000000000000b5 Apr 21 08:16:20 volumio-n1 kernel: [RX]-receive ksv list len:1,depth:1,cas:0,dev:0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: video: get current mode: 1080p60hz Apr 21 08:16:20 volumio-n1 kernel: hdmitx: update rx hdr info 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: update physcial size: 600 330 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: already init VIC = 0 Now VIC = 16 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: rx no SCDC present indicator Apr 21 08:16:20 volumio-n1 kernel: hdmitx: ddc rd8b error 0x54 0x01 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: irq 80000001 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: ddc rd8b error 0x54 0x01 Apr 21 08:16:20 volumio-n1 kernel: Start = 0x10000100 End = 0x100001ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000104]: 0x00000001 Apr 21 08:16:20 volumio-n1 kernel: [0x10000105]: 0x00000003 Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe: driver initialized ok Apr 21 08:16:20 volumio-n1 kernel: [0x10000170]: 0x00000004 Apr 21 08:16:20 volumio-n1 kernel: rdma_register, rdma_table_addr ffffff8000750000 rdma_table_addr_phy 67052000 reg_buf ffffffc061d93000 Apr 21 08:16:20 volumio-n1 kernel: rdma_register success, handle 6 table_size 512 Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe:vdin.1 rdma hanld 6. Apr 21 08:16:20 volumio-n1 kernel: vdin1 has 1 memory regions Apr 21 08:16:20 volumio-n1 kernel: vdin vdin1.27: assigned reserved memory node linux,vdin1_cma ok Apr 21 08:16:20 volumio-n1 kernel: vdin memory resource done. Apr 21 08:16:20 volumio-n1 kernel: vdin1 cma_mem_size = 16 MB Apr 21 08:16:20 volumio-n1 kernel: vdin1 irq: 117 rdma irq: 4 Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe: fclk_div5 is 400 MHZ Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe: vdin[1] clock is 50 MHZ Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_probe: driver initialized ok Apr 21 08:16:20 volumio-n1 kernel: vdin_drv_init: vdin driver init done Apr 21 08:16:20 volumio-n1 kernel: tvafe_drv_init: major 227 Apr 21 08:16:20 volumio-n1 kernel: tvafe: tvafe_init. Apr 21 08:16:20 volumio-n1 kernel: [RX]-hdmirx: hdmirx_init. Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: Initializing... Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: Registering device range 'esm_rx'... Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: Device range 'esm_rx' has been registered. Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: Creating class /sys/class/elliptic_rx... Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: The class /sys/class/elliptic_rx has been created. Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: Creating device 'esm_rx'... Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: Device 'esm_rx' has been created. Apr 21 08:16:20 volumio-n1 kernel: ESM HLD: Done initializing the HLD driver. Apr 21 08:16:20 volumio-n1 kernel: module init Apr 21 08:16:20 volumio-n1 kernel: VECM probe start Apr 21 08:16:20 volumio-n1 kernel: aml_vecm_probe: ok Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: initialized by BL30 Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: calibration start: Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: nominal=0, value=6 Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: nominal=256, value=233 Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: nominal=512, value=460 Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: nominal=768, value=687 Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: nominal=1023, value=919 Apr 21 08:16:20 volumio-n1 kernel: saradc c1108680.saradc: calibration end: coef=4619 Apr 21 08:16:20 volumio-n1 kernel: remote: Driver init Apr 21 08:16:20 volumio-n1 kernel: remote: platform_data g_remote_ao_offset=580 Apr 21 08:16:20 volumio-n1 kernel: remote: platform_data irq =228 Apr 21 08:16:20 volumio-n1 kernel: [30B blob data] Apr 21 08:16:20 volumio-n1 kernel: [38B blob data] Apr 21 08:16:20 volumio-n1 kernel: input: aml_keypad as /devices/meson-remote.11/input/input0 Apr 21 08:16:20 volumio-n1 kernel: [41B blob data] Apr 21 08:16:20 volumio-n1 kernel: remote: set_remote_mode[78] Apr 21 08:16:20 volumio-n1 kernel: [32B blob data] Apr 21 08:16:20 volumio-n1 kernel: remote: physical address:0x61ede000 Apr 21 08:16:20 volumio-n1 kernel: gpio-key gpio_keypad.48: gpio_key: 0 name(power) pin() Apr 21 08:16:20 volumio-n1 kernel: gpio-key gpio_keypad.48: amlogic_gpio_name_map_num pin 0!:: Apr 21 08:16:20 volumio-n1 kernel: gpio-key gpio_keypad.48: gpio_key: 0 power(147) Apr 21 08:16:20 volumio-n1 kernel: gpio-key gpio_keypad.48: start setup_timer Apr 21 08:16:20 volumio-n1 kernel: gpio-key gpio_keypad.48: power key(116) registed. Apr 21 08:16:20 volumio-n1 kernel: input: gpio_keypad as /devices/gpio_keypad.48/input/input1 Apr 21 08:16:20 volumio-n1 kernel: gpio-key gpio_keypad.48: gpio keypad register input device completed. Apr 21 08:16:20 volumio-n1 kernel: input input1: gpio keypad major:222 Apr 21 08:16:20 volumio-n1 kernel: Sensor: lsm303d_init Apr 21 08:16:20 volumio-n1 kernel: Sensor: stk8313_init Apr 21 08:16:20 volumio-n1 kernel: Sensor: stk831x_init Apr 21 08:16:20 volumio-n1 kernel: Sensor: mxc622x_acc_init Apr 21 08:16:20 volumio-n1 kernel: Sensor: mxc6255xc_acc_init Apr 21 08:16:20 volumio-n1 kernel: Sensor: l3gd20_gyr_init Apr 21 08:16:20 volumio-n1 kernel: cpuinfo: probe done Apr 21 08:16:20 volumio-n1 kernel: defendkey c8834500.defendkey: defendkey_devno:dc00000 Apr 21 08:16:20 volumio-n1 kernel: defendkey c8834500.defendkey: defendkey: device defendkey created ok Apr 21 08:16:20 volumio-n1 kernel: defendkey: driver init Apr 21 08:16:20 volumio-n1 kernel: input: cec_input as /devices/virtual/input/input2 Apr 21 08:16:20 volumio-n1 kernel: cectx aocec: aml_cec_probe(): no hdmirx reg resource Apr 21 08:16:20 volumio-n1 kernel: cectx aocec: aml_cec_probe(): no hhi reg resource Apr 21 08:16:20 volumio-n1 kernel: cectx aocec: aml_cec_probe(): can't find hdmirx Apr 21 08:16:20 volumio-n1 kernel: cec: wake up flag:0 Apr 21 08:16:20 volumio-n1 kernel: aml_codec_T9015 c8832000.t9015: aml_T9015_audio_codec_probe Apr 21 08:16:20 volumio-n1 kernel: aml_pcm_dai: pcm mode detection =1 Apr 21 08:16:20 volumio-n1 kernel: aml_spdif_dai: enterd aml_spdif_play,set_clock:-1,sample_rate=4 Apr 21 08:16:20 volumio-n1 kernel: aml_spdif_dai: set normal 512 fs /4 fs Apr 21 08:16:20 volumio-n1 kernel: aml_audio_hw: IEC958 16bit Apr 21 08:16:20 volumio-n1 kernel: hdmitx: audio: aout notify rate 48000 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: audio: aout notify size 16 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: audio: aout notify format CT_PCM Apr 21 08:16:20 volumio-n1 kernel: input input1: key 116 up Apr 21 08:16:20 volumio-n1 kernel: aml_snd_card: headphone detection disable=1 Apr 21 08:16:20 volumio-n1 kernel: aml_snd_m8_card aml_m8_snd.47: T9015-audio-hifi <-> I2S.40 mapping ok Apr 21 08:16:20 volumio-n1 kernel: aml_snd_m8_card aml_m8_snd.47: dit-hifi <-> SPDIF.41 mapping ok Apr 21 08:16:20 volumio-n1 kernel: aml_pcm: enter aml_pcm_new dai->name: PCM.42 dai->id: 0 Apr 21 08:16:20 volumio-n1 kernel: aml_snd_m8_card aml_m8_snd.47: pcm2bt-pcm <-> PCM.42 mapping ok Apr 21 08:16:20 volumio-n1 kernel: aml_snd_m8_card aml_m8_snd.47: ASoC: no source widget found for LOUTL Apr 21 08:16:20 volumio-n1 kernel: aml_snd_m8_card aml_m8_snd.47: ASoC: Failed to add route LOUTL -> direct -> Ext Spk Apr 21 08:16:20 volumio-n1 kernel: aml_snd_m8_card aml_m8_snd.47: ASoC: no source widget found for LOUTR Apr 21 08:16:20 volumio-n1 kernel: aml_snd_m8_card aml_m8_snd.47: ASoC: Failed to add route LOUTR -> direct -> Ext Spk Apr 21 08:16:20 volumio-n1 kernel: aml_snd_card: audio use jtag pinmux as i2s output, read val =0 Apr 21 08:16:20 volumio-n1 kernel: GACT probability NOT on Apr 21 08:16:20 volumio-n1 kernel: Mirror/redirect action on Apr 21 08:16:20 volumio-n1 kernel: u32 classifier Apr 21 08:16:20 volumio-n1 kernel: Actions configured Apr 21 08:16:20 volumio-n1 kernel: Netfilter messages via NETLINK v0.30. Apr 21 08:16:20 volumio-n1 kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Apr 21 08:16:20 volumio-n1 kernel: ctnetlink v0.93: registering with nfnetlink. Apr 21 08:16:20 volumio-n1 kernel: xt_time: kernel timezone is -0000 Apr 21 08:16:20 volumio-n1 kernel: ipip: IPv4 over IPv4 tunneling driver Apr 21 08:16:20 volumio-n1 kernel: hdmirx version is 1.4 or below Apr 21 08:16:20 volumio-n1 kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Apr 21 08:16:20 volumio-n1 kernel: hdmitx div40: 0 Apr 21 08:16:20 volumio-n1 kernel: arp_tables: (C) 2002 David S. Miller Apr 21 08:16:20 volumio-n1 kernel: TCP: cubic registered Apr 21 08:16:20 volumio-n1 kernel: [0x10000180]: 0x000000ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000181]: 0x000000ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000182]: 0x00000003 Apr 21 08:16:20 volumio-n1 kernel: [0x10000183]: 0x00000007 Apr 21 08:16:20 volumio-n1 kernel: [0x10000184]: 0x0000003f Apr 21 08:16:20 volumio-n1 kernel: [0x10000185]: 0x00000002 Apr 21 08:16:20 volumio-n1 kernel: [0x10000187]: 0x000000ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000188]: 0x00000003 Apr 21 08:16:20 volumio-n1 kernel: Initializing XFRM netlink socket Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 10 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: set mode VIC 16 (cd0,cs0,pm1,vd0,1) Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: set pll Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: param->VIC:16 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: set clk: VIC = 16 cd = 4 frac_rate = 0 Apr 21 08:16:20 volumio-n1 kernel: config HPLL = 2970000 Apr 21 08:16:20 volumio-n1 kernel: HPLL: 0xc000027b Apr 21 08:16:20 volumio-n1 kernel: config HPLL done Apr 21 08:16:20 volumio-n1 kernel: set_hpll_od3_clk_div[437] div = 6 Apr 21 08:16:20 volumio-n1 kernel: j = 4 vid_clk_div = 1 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: set enc for VIC: 16 Apr 21 08:16:20 volumio-n1 kernel: hdmitx_set_hw[4947] set VIC = 16 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: irq 80000001 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: irq 80000001 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: ddc w1b error 0x54 0x20 0x00 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: ddc w1b error 0x54 0x20 0x00 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: ddc rd8b error 0x54 0x21 Apr 21 08:16:20 volumio-n1 kernel: Start = 0x10000100 End = 0x100001ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000104]: 0x00000001 Apr 21 08:16:20 volumio-n1 kernel: [0x10000180]: 0x000000ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000181]: 0x000000ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000182]: 0x00000003 Apr 21 08:16:20 volumio-n1 kernel: [0x10000183]: 0x00000007 Apr 21 08:16:20 volumio-n1 kernel: [0x10000184]: 0x0000003f Apr 21 08:16:20 volumio-n1 kernel: [0x10000185]: 0x00000002 Apr 21 08:16:20 volumio-n1 kernel: [0x10000187]: 0x000000ff Apr 21 08:16:20 volumio-n1 kernel: [0x10000188]: 0x00000003 Apr 21 08:16:20 volumio-n1 kernel: mip6: Mobile IPv6 Apr 21 08:16:20 volumio-n1 kernel: ip6_tables: (C) 2000-2006 Netfilter Core Team Apr 21 08:16:20 volumio-n1 kernel: sit: IPv6 over IPv4 tunneling driver Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 17 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: PHY Setting Done Apr 21 08:16:20 volumio-n1 kernel: Sink is HDMI device Apr 21 08:16:20 volumio-n1 kernel: hdmitx: system: packet: can't get vendor data Apr 21 08:16:20 volumio-n1 kernel: 1080p60hz 60 1 Apr 21 08:16:20 volumio-n1 kernel: 1080p60hz 60 1 Apr 21 08:16:20 volumio-n1 kernel: hdmtix: set audio Apr 21 08:16:20 volumio-n1 kernel: hdmitx tx_aud_src = 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148500 Apr 21 08:16:20 volumio-n1 kernel: hdmitx aud_n_para = 6144 Apr 21 08:16:20 volumio-n1 kernel: hdmitx set channel status Apr 21 08:16:20 volumio-n1 kernel: hdmitx: audio: Audio Type: PCM Apr 21 08:16:20 volumio-n1 kernel: hdmtix: set audio Apr 21 08:16:20 volumio-n1 kernel: hdmitx tx_aud_src = 0 Apr 21 08:16:20 volumio-n1 kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148500 Apr 21 08:16:20 volumio-n1 kernel: hdmitx aud_n_para = 6144 Apr 21 08:16:20 volumio-n1 kernel: hdmitx set channel status Apr 21 08:16:20 volumio-n1 kernel: hdmitx: audio: Audio Type: PCM Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 15 Apr 21 08:16:20 volumio-n1 kernel: Bridge firewalling registered Apr 21 08:16:20 volumio-n1 kernel: l2tp_core: L2TP core driver, V2.0 Apr 21 08:16:20 volumio-n1 kernel: l2tp_ip: L2TP IP encapsulation support (L2TPv3) Apr 21 08:16:20 volumio-n1 kernel: l2tp_netlink: L2TP netlink interface Apr 21 08:16:20 volumio-n1 kernel: l2tp_eth: L2TP ethernet pseudowire support (L2TPv3) Apr 21 08:16:20 volumio-n1 kernel: l2tp_debugfs: L2TP debugfs support Apr 21 08:16:20 volumio-n1 kernel: l2tp_ip6: L2TP IP encapsulation support for IPv6 (L2TPv3) Apr 21 08:16:20 volumio-n1 kernel: NET: Registered protocol family 35 Apr 21 08:16:20 volumio-n1 kernel: Key type dns_resolver registered Apr 21 08:16:20 volumio-n1 kernel: Registering SWP/SWPB emulation handler Apr 21 08:16:20 volumio-n1 kernel: bio: create slab at 1 Apr 21 08:16:20 volumio-n1 kernel: Btrfs loaded Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running btrfs free space cache tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running extent only tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running bitmap only tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running bitmap and extent tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Free space cache tests finished Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running extent buffer operation tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running btrfs_split_item tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running find delalloc tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running btrfs_get_extent tests Apr 21 08:16:20 volumio-n1 kernel: BTRFS: selftest: Running hole first btrfs_get_extent test Apr 21 08:16:20 volumio-n1 kernel: regulator-dummy: disabling Apr 21 08:16:20 volumio-n1 kernel: Mali DRM initialize, driver name: mali_drm, version 2.1 Apr 21 08:16:20 volumio-n1 kernel: [drm] Initialized mali_drm 2.1.1 20140306 on minor 0 Apr 21 08:16:20 volumio-n1 kernel: Mali DRM initialize, driver name: mali_drm, version 2.1 Apr 21 08:16:20 volumio-n1 kernel: [drm] Initialized mali_drm 2.1.1 20140306 on minor 1 Apr 21 08:16:20 volumio-n1 kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Apr 21 08:16:20 volumio-n1 kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1 Apr 21 08:16:20 volumio-n1 kernel: xhci-hcd xhci-hcd.0.auto: irq 62, io mem 0xc9000000 Apr 21 08:16:20 volumio-n1 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Apr 21 08:16:20 volumio-n1 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 21 08:16:20 volumio-n1 kernel: usb usb1: Product: xHCI Host Controller Apr 21 08:16:20 volumio-n1 kernel: usb usb1: Manufacturer: Linux 3.14.29 xhci-hcd Apr 21 08:16:20 volumio-n1 kernel: usb usb1: SerialNumber: xhci-hcd.0.auto Apr 21 08:16:20 volumio-n1 kernel: hub 1-0:1.0: USB hub found Apr 21 08:16:20 volumio-n1 kernel: hub 1-0:1.0: 2 ports detected Apr 21 08:16:20 volumio-n1 kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Apr 21 08:16:20 volumio-n1 kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 Apr 21 08:16:20 volumio-n1 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 Apr 21 08:16:20 volumio-n1 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Apr 21 08:16:20 volumio-n1 kernel: usb usb2: Product: xHCI Host Controller Apr 21 08:16:20 volumio-n1 kernel: usb usb2: Manufacturer: Linux 3.14.29 xhci-hcd Apr 21 08:16:20 volumio-n1 kernel: usb usb2: SerialNumber: xhci-hcd.0.auto Apr 21 08:16:20 volumio-n1 kernel: hub 2-0:1.0: USB hub found Apr 21 08:16:20 volumio-n1 kernel: hub 2-0:1.0: config failed, hub doesn't have any ports! (err -19) Apr 21 08:16:20 volumio-n1 kernel: console [netcon0] enabled Apr 21 08:16:20 volumio-n1 kernel: netconsole: network logging started Apr 21 08:16:20 volumio-n1 kernel: aml_vrtc rtc.32: setting system clock to 2025-04-21 08:16:12 UTC (1745223372) Apr 21 08:16:20 volumio-n1 kernel: cpufreq-scpi cpufreq-meson.7: enter cpufreq Apr 21 08:16:20 volumio-n1 kernel: cpufreq-scpi cpufreq-meson.7: probe cpufreq okay Apr 21 08:16:20 volumio-n1 kernel: hdmirx_ext: [hdmiin_drv_init] ver: Jul042016.1 Apr 21 08:16:20 volumio-n1 kernel: gxbb_pm: enter meson_pm_probe! Apr 21 08:16:20 volumio-n1 kernel: gxbb_pm: meson_pm_probe done Apr 21 08:16:20 volumio-n1 kernel: cpucore_cooling_register, max_cpu_core_num:4 Apr 21 08:16:20 volumio-n1 kernel: aml_istbt_dev_ready NULL Apr 21 08:16:20 volumio-n1 kernel: ALSA device list: Apr 21 08:16:20 volumio-n1 kernel: #0: AML-M8AUDIO Apr 21 08:16:20 volumio-n1 kernel: Freeing unused kernel memory: 1236K (ffffffc001f2d000 - ffffffc002062000) Apr 21 08:16:20 volumio-n1 kernel: usb 1-1: new low-speed USB device number 2 using xhci-hcd Apr 21 08:16:20 volumio-n1 initramfs: Boot delay will be 5 seconds to give kernel load a headstart Apr 21 08:16:20 volumio-n1 kernel: usb 1-1: New USB device found, idVendor=17ef, idProduct=608d Apr 21 08:16:20 volumio-n1 kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Apr 21 08:16:20 volumio-n1 kernel: usb 1-1: Product: Lenovo USB Optical Mouse Apr 21 08:16:20 volumio-n1 kernel: usb 1-1: Manufacturer: PixArt Apr 21 08:16:20 volumio-n1 kernel: usb 1-1: ep 0x81 - rounding interval to 64 microframes, ep desc says 80 microframes Apr 21 08:16:20 volumio-n1 kernel: input: PixArt Lenovo USB Optical Mouse as /devices/c9000000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1:1.0/0003:17EF:608D.0001/input/input3 Apr 21 08:16:20 volumio-n1 kernel: hid-generic 0003:17EF:608D.0001: input,hidraw0: USB HID v1.11 Mouse [PixArt Lenovo USB Optical Mouse] on usb-xhci-hcd.0.auto-1/input0 Apr 21 08:16:20 volumio-n1 kernel: usb 1-2: new high-speed USB device number 3 using xhci-hcd Apr 21 08:16:20 volumio-n1 kernel: usb 1-2: New USB device found, idVendor=ffff, idProduct=5678 Apr 21 08:16:20 volumio-n1 kernel: usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 21 08:16:20 volumio-n1 kernel: usb 1-2: Product: Disk 2.0 Apr 21 08:16:20 volumio-n1 kernel: usb 1-2: Manufacturer: USB Apr 21 08:16:20 volumio-n1 kernel: usb 1-2: SerialNumber: 2783181153406572269 Apr 21 08:16:20 volumio-n1 kernel: usb-storage 1-2:1.0: USB Mass Storage device detected Apr 21 08:16:20 volumio-n1 kernel: scsi0 : usb-storage 1-2:1.0 Apr 21 08:16:20 volumio-n1 kernel: scsi 0:0:0:0: Direct-Access VendorCo ProductCode 2.00 PQ: 0 ANSI: 4 Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] 61440000 512-byte logical blocks: (31.4 GB/29.2 GiB) Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] Write Protect is off Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] Mode Sense: 03 00 00 00 Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] No Caching mode page found Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] No Caching mode page found Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Apr 21 08:16:20 volumio-n1 kernel: sda: sda1 sda2 sda3 Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] No Caching mode page found Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Apr 21 08:16:20 volumio-n1 kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Apr 21 08:16:20 volumio-n1 kernel: random: nonblocking pool is initialized Apr 21 08:16:20 volumio-n1 initramfs: Booting Volumio for Amlogic Apr 21 08:16:20 volumio-n1 initramfs: This script mounts rootfs RO with an overlay RW layer. Apr 21 08:16:20 volumio-n1 initramfs: IMGPART=/dev/sda2 Apr 21 08:16:20 volumio-n1 initramfs: IMGFILE=/volumio_current.sqsh Apr 21 08:16:20 volumio-n1 initramfs: DATAPART=/dev/sda3 Apr 21 08:16:20 volumio-n1 initramfs: BOOTPART=/dev/sda1 Apr 21 08:16:20 volumio-n1 initramfs: BOOTCONFIG=empty Apr 21 08:16:20 volumio-n1 kernel: EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null) Apr 21 08:16:20 volumio-n1 initramfs: Checking for USB updates if you did not boot from USB... Apr 21 08:16:20 volumio-n1 initramfs: Not checking for firmware if you boot from USB. Sorry! Apr 21 08:16:20 volumio-n1 kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Apr 21 08:16:20 volumio-n1 kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Apr 21 08:16:20 volumio-n1 kernel: EXT4-fs (sda3): warning: mounting fs with errors, running e2fsck is recommended Apr 21 08:16:20 volumio-n1 kernel: EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null) Apr 21 08:16:20 volumio-n1 initramfs: With Option: Apr 21 08:16:20 volumio-n1 initramfs: Incompatible fstab, no entry found for /boot Apr 21 08:16:20 volumio-n1 initramfs: found fstab entry with device for /boot Apr 21 08:16:20 volumio-n1 kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Apr 21 08:16:20 volumio-n1 initramfs: VOLUMIO_VERSION="2.603" Apr 21 08:16:20 volumio-n1 initramfs: Finish initramfs, continue booting Volumio Apr 21 08:16:20 volumio-n1 systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR) Apr 21 08:16:20 volumio-n1 systemd[1]: Detected architecture 'arm64'. Apr 21 08:16:20 volumio-n1 systemd[1]: Set hostname to . Apr 21 08:16:20 volumio-n1 kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 08:16:20 volumio-n1 systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Apr 21 08:16:20 volumio-n1 systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Apr 21 08:16:20 volumio-n1 systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Apr 21 08:16:20 volumio-n1 systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Apr 21 08:16:20 volumio-n1 systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Forward Password Requests to Wall Directory Watch. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Apr 21 08:16:20 volumio-n1 systemd[1]: Expecting device dev-ttyS0.device... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Remote File Systems (Pre). Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Remote File Systems (Pre). Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Arbitrary Executable File Formats File System Automount Point. Apr 21 08:16:20 volumio-n1 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Encrypted Volumes. Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Encrypted Volumes. Apr 21 08:16:20 volumio-n1 systemd[1]: Expecting device dev-disk-by\x2dlabel-BOOT.device... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Root Slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice Root Slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting User and Session Slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice User and Session Slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting /dev/initctl Compatibility Named Pipe. Apr 21 08:16:20 volumio-n1 systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Delayed Shutdown Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Listening on Delayed Shutdown Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Journal Socket (/dev/log). Apr 21 08:16:20 volumio-n1 systemd[1]: Listening on Journal Socket (/dev/log). Apr 21 08:16:20 volumio-n1 systemd[1]: Starting udev Control Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Listening on udev Control Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting udev Kernel Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Listening on udev Kernel Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Journal Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Listening on Journal Socket. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting System Slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice System Slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting system-systemd\x2dfsck.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice system-systemd\x2dfsck.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting dynamicswap service... Apr 21 08:16:20 volumio-n1 systemd[1]: Started dynamicswap service. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Swap. Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Swap. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting system-getty.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice system-getty.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting system-serial\x2dgetty.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice system-serial\x2dgetty.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Restore / save the current clock... Apr 21 08:16:20 volumio-n1 systemd[1]: Mounting Huge Pages File System... Apr 21 08:16:20 volumio-n1 systemd[1]: Mounting POSIX Message Queue File System... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Create list of required static device nodes for the current kernel... Apr 21 08:16:20 volumio-n1 systemd[1]: Mounting Debug File System... Apr 21 08:16:20 volumio-n1 systemd[1]: Started Set Up Additional Binary Formats. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Load Kernel Modules... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting udev Coldplug all Devices... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Journal Service... Apr 21 08:16:20 volumio-n1 systemd[1]: Started Journal Service. Apr 21 08:16:20 volumio-n1 kernel: cfg80211: Calling CRDA to update world regulatory domain Apr 21 08:16:20 volumio-n1 kernel: dhd_module_init: in Dongle Host Driver, version 1.363.59.144.9 (r) Apr 21 08:16:20 volumio-n1 kernel: ======== dhd_wlan_init_plat_data ======== Apr 21 08:16:20 volumio-n1 kernel: dhd_wlan_init_gpio: GPIO(WL_REG_ON) = -1 Apr 21 08:16:20 volumio-n1 kernel: dhd_wlan_init_gpio: GPIO(WL_HOST_WAKE) = -1 Apr 21 08:16:20 volumio-n1 kernel: dhd_wlan_init_gpio: host_oob_irq: 100 Apr 21 08:16:20 volumio-n1 kernel: dhd_wlan_init_gpio: host_oob_irq_flags=0x414 Apr 21 08:16:20 volumio-n1 kernel: dhd_wifi_platform_load: Enter Apr 21 08:16:20 volumio-n1 kernel: Power-up adapter 'DHD generic adapter' Apr 21 08:16:20 volumio-n1 kernel: wifi_platform_set_power = 1 Apr 21 08:16:20 volumio-n1 kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 08:16:20 volumio-n1 systemd-journal[2895]: Journal started Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Slices. Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Slices. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Remount Root and Kernel File Systems... Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted Debug File System. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted POSIX Message Queue File System. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted Huge Pages File System. Apr 21 08:16:20 volumio-n1 systemd-modules-load[2893]: Module 'fuse' is builtin Apr 21 08:16:20 volumio-n1 systemd[1]: Started Restore / save the current clock. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Create list of required static device nodes for the current kernel. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Remount Root and Kernel File Systems. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Various fixups to make systemd work better on Debian. Apr 21 08:16:20 volumio-n1 fake-hwclock[2874]: Current system time: 2025-04-21 08:16:19 Apr 21 08:16:20 volumio-n1 fake-hwclock[2874]: fake-hwclock saved clock information is in the past: 2025-03-29 13:26:58 Apr 21 08:16:20 volumio-n1 fake-hwclock[2874]: To set system time to this saved clock anyway, use "force" Apr 21 08:16:20 volumio-n1 systemd[1]: Started Load/Save Random Seed. Apr 21 08:16:20 volumio-n1 systemd[1]: Started udev Coldplug all Devices. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Create Static Device Nodes in /dev. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting udev Kernel Device Manager... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Local File Systems (Pre). Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Local File Systems (Pre). Apr 21 08:16:20 volumio-n1 systemd[1]: Mounting /tmp... Apr 21 08:16:20 volumio-n1 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounting /var/spool/cups... Apr 21 08:16:20 volumio-n1 systemd-udevd[4191]: starting version 215 Apr 21 08:16:20 volumio-n1 systemd[1]: Mounting /var/log... Apr 21 08:16:20 volumio-n1 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted /tmp. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted /var/log. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted /var/spool/cups. Apr 21 08:16:20 volumio-n1 systemd[1]: Started udev Kernel Device Manager. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Show Plymouth Boot Screen. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Dispatch Password Requests to Console Directory Watch. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Paths. Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Paths. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Copy rules generated while the root was ro... Apr 21 08:16:20 volumio-n1 kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 08:16:20 volumio-n1 systemd[1]: Mounting /var/spool/cups/tmp... Apr 21 08:16:20 volumio-n1 systemd[1]: Started Copy rules generated while the root was ro. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted /var/spool/cups/tmp. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Local File Systems. Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Local File Systems. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Remote File Systems. Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Remote File Systems. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Create Volatile Files and Directories... Apr 21 08:16:20 volumio-n1 systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Apr 21 08:16:20 volumio-n1 systemd[1]: Started Create Volatile Files and Directories. Apr 21 08:16:20 volumio-n1 systemd[1]: Mounted FUSE Control File System. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Update UTMP about System Boot/Shutdown... Apr 21 08:16:20 volumio-n1 systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Apr 21 08:16:20 volumio-n1 systemd[1]: Found device /dev/ttyS0. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Sound Card. Apr 21 08:16:20 volumio-n1 systemd[1]: Reached target Sound Card. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting system-systemd\x2drfkill.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice system-systemd\x2drfkill.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill0... Apr 21 08:16:20 volumio-n1 kernel: BT_RADIO going: on Apr 21 08:16:20 volumio-n1 kernel: BCM_BT: going ON Apr 21 08:16:20 volumio-n1 systemd[1]: Started Update UTMP about System Boot/Shutdown. Apr 21 08:16:20 volumio-n1 kernel: wifi_platform_bus_enumerate device present 1 Apr 21 08:16:20 volumio-n1 kernel: ======== Card detection to detect SDIO card! ======== Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 08:16:20 volumio-n1 kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 08:16:20 volumio-n1 kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 08:16:20 volumio-n1 systemd[1]: Starting system-ifup.slice. Apr 21 08:16:20 volumio-n1 systemd[1]: Created slice system-ifup.slice. Apr 21 08:16:20 volumio-n1 kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 08:16:20 volumio-n1 kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 08:16:20 volumio-n1 kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:8 Apr 21 08:16:20 volumio-n1 kernel: cfg80211: World regulatory domain updated: Apr 21 08:16:20 volumio-n1 kernel: cfg80211: DFS Master region: unset Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (N/A, 2000 mBm) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz), (N/A, 2000 mBm) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm) Apr 21 08:16:20 volumio-n1 kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm) Apr 21 08:16:20 volumio-n1 kernel: sdio: clk 200000000 SDR mode tuning start Apr 21 08:16:21 volumio-n1 systemd[1]: Started Load/Save RF Kill Switch Status of rfkill0. Apr 21 08:16:21 volumio-n1 kernel: sdio: rx_tuning_result[0] = 10 Apr 21 08:16:21 volumio-n1 kernel: sdio: rx_tuning_result[1] = 10 Apr 21 08:16:21 volumio-n1 kernel: sdio: rx_tuning_result[2] = 10 Apr 21 08:16:21 volumio-n1 kernel: sdio: rx_tuning_result[4] = 10 Apr 21 08:16:21 volumio-n1 kernel: sdio: best_win_start =4, best_win_size =4 Apr 21 08:16:21 volumio-n1 kernel: sdio: sd_emmc_regs->gclock=0x1000245,sd_emmc_regs->gadjust=0x12000 Apr 21 08:16:21 volumio-n1 kernel: sdio: gclock =0x1000245, gdelay=0x0, gadjust=0x12000 Apr 21 08:16:21 volumio-n1 kernel: sdio: queuing unknown CIS tuple 0x91 (3 bytes) Apr 21 08:16:21 volumio-n1 kernel: sdio: new ultra high speed SDR104 SDIO card at address 0001 Apr 21 08:16:21 volumio-n1 kernel: sdio: clock 200000000, 4-bit-bus-width Apr 21 08:16:21 volumio-n1 kernel: [sdio_reinit] finish Apr 21 08:16:21 volumio-n1 kernel: bcmsdh_register: register client driver Apr 21 08:16:21 volumio-n1 kernel: bcmsdh_sdmmc: bcmsdh_sdmmc_probe Enter Apr 21 08:16:21 volumio-n1 kernel: bcmsdh_sdmmc: bcmsdh_sdmmc_probe Enter Apr 21 08:16:21 volumio-n1 kernel: bus num (host idx)=0, slot num (rca)=1 Apr 21 08:16:21 volumio-n1 kernel: found adapter info 'DHD generic adapter' Apr 21 08:16:21 volumio-n1 kernel: Wifi: bcmdhd_mem_prealloc: 7 bcmdhd_mem_prealloc: wlan_mem_array[section].mem_ptr=ffffffc0020fc8b8, size=139264 Apr 21 08:16:21 volumio-n1 kernel: success alloc section 3, size 139264 Apr 21 08:16:21 volumio-n1 kernel: alloc static buf at ffffffc062100000! Apr 21 08:16:21 volumio-n1 kernel: Wifi: bcmdhd_mem_prealloc: 1 bcmdhd_mem_prealloc: section=4, wlan_static_skb=ffffffc00257b928 Apr 21 08:16:21 volumio-n1 kernel: success alloc section 4, size 0 Apr 21 08:16:21 volumio-n1 kernel: sdioh_attach: set sd_f2_blocksize 256 Apr 21 08:16:21 volumio-n1 kernel: dhdsdio_probe : no mutex held. set lock Apr 21 08:16:21 volumio-n1 kernel: F1 signature read @0x18000000=0x15264345 Apr 21 08:16:21 volumio-n1 kernel: F1 signature OK, socitype:0x1 chip:0x4345 rev:0x6 pkg:0x2 Apr 21 08:16:21 volumio-n1 kernel: DHD: dongle ram size is set to 819200(orig 819200) at 0x198000 Apr 21 08:16:21 volumio-n1 kernel: Wifi: bcmdhd_mem_prealloc: 4 bcmdhd_mem_prealloc: section=7, wlan_mem_array[4]=ffffffc062b08000 Apr 21 08:16:21 volumio-n1 kernel: success alloc section 7, size 31312 Apr 21 08:16:21 volumio-n1 kernel: dhd_conf_set_chiprev: chip=0x4345, chiprev=6 Apr 21 08:16:21 volumio-n1 kernel: Wifi: bcmdhd_mem_prealloc: 7 bcmdhd_mem_prealloc: wlan_mem_array[section].mem_ptr=ffffffc0020fc888, size=10544 Apr 21 08:16:21 volumio-n1 kernel: success alloc section 0, size 10544 Apr 21 08:16:21 volumio-n1 kernel: Wifi: bcmdhd_mem_prealloc: 2 bcmdhd_mem_prealloc: section=5, wlan_static_scan_buf0=ffffffc062bb0000 Apr 21 08:16:21 volumio-n1 kernel: success alloc section 5, size 65536 Apr 21 08:16:21 volumio-n1 kernel: wl_create_event_handler(): thread:wl_event_handler:10bf started Apr 21 08:16:21 volumio-n1 kernel: tsk Enter, tsk = 0xffffff80013e2bb8 Apr 21 08:16:21 volumio-n1 kernel: wl_escan_attach: Enter Apr 21 08:16:21 volumio-n1 kernel: wl_escan_init: Enter Apr 21 08:16:21 volumio-n1 kernel: wl_create_event_handler(): thread:wl_escan_handler:10c1 started Apr 21 08:16:21 volumio-n1 kernel: dhd_attach(): thread:dhd_watchdog_thread:10c2 started Apr 21 08:16:21 volumio-n1 kernel: dhd_attach(): thread:dhd_dpc:10c3 started Apr 21 08:16:21 volumio-n1 kernel: tsk Enter, tsk = 0xffffffc0520f01a0 Apr 21 08:16:21 volumio-n1 kernel: dhd_attach(): thread:dhd_rxf:10c4 started Apr 21 08:16:21 volumio-n1 kernel: dhd_deferred_work_init: work queue initialized Apr 21 08:16:21 volumio-n1 kernel: Wifi: bcmdhd_mem_prealloc: 7 bcmdhd_mem_prealloc: wlan_mem_array[section].mem_ptr=ffffffc0020fc898, size=10524 Apr 21 08:16:21 volumio-n1 kernel: success alloc section 1, size 10524 Apr 21 08:16:21 volumio-n1 kernel: Wifi: bcmdhd_mem_prealloc: 7 bcmdhd_mem_prealloc: wlan_mem_array[section].mem_ptr=ffffffc0020fc8a8, size=65536 Apr 21 08:16:21 volumio-n1 kernel: success alloc section 2, size 65536 Apr 21 08:16:21 volumio-n1 kernel: Dongle Host Driver, version 1.363.59.144.9 (r) Apr 21 08:16:21 volumio-n1 kernel: Register interface [wlan0] MAC: 00:90:4c:11:22:33 Apr 21 08:16:21 volumio-n1 kernel: wl_event_handler: was terminated Apr 21 08:16:21 volumio-n1 kernel: wl_destroy_event_handler(): thread:wl_event_handler:10bf terminated OK Apr 21 08:16:21 volumio-n1 kernel: dhd_wl_ioctl: returning as busstate=0 Apr 21 08:16:21 volumio-n1 kernel: bcmsdh_oob_intr_unregister: Enter Apr 21 08:16:21 volumio-n1 kernel: bcmsdh_oob_intr_unregister: irq is not registered Apr 21 08:16:21 volumio-n1 kernel: dhd_txglom_enable: enable 0 Apr 21 08:16:21 volumio-n1 kernel: dhd_conf_set_txglom_params: swtxglom=0, txglom_ext=0, txglom_bucket_size=0 Apr 21 08:16:21 volumio-n1 kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0, bus_txglom=-1 Apr 21 08:16:21 volumio-n1 kernel: dhd_conf_set_txglom_params: tx_in_rx=1, txinrx_thres=-1, dhd_txminmax=1 Apr 21 08:16:21 volumio-n1 kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=1 Apr 21 08:16:21 volumio-n1 kernel: sdioh_set_mode: set txglom_mode to multi-desc Apr 21 08:16:21 volumio-n1 kernel: dhd_bus_devreset: WLAN OFF DONE Apr 21 08:16:21 volumio-n1 kernel: wifi_platform_set_power = 0 Apr 21 08:16:21 volumio-n1 kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 08:16:21 volumio-n1 kernel: dhdsdio_probe : the lock is released. Apr 21 08:16:21 volumio-n1 systemd-modules-load[2893]: Inserted module 'dhd' Apr 21 08:16:21 volumio-n1 systemd-modules-load[2893]: Failed to find module 'snd_soc_pcm5102' Apr 21 08:16:21 volumio-n1 systemd-modules-load[2893]: Failed to find module 'snd_soc_odroid_dac' Apr 21 08:16:21 volumio-n1 systemd[1]: systemd-modules-load.service: main process exited, code=exited, status=1/FAILURE Apr 21 08:16:21 volumio-n1 kernel: dhd_module_init: Exit err=0 Apr 21 08:16:21 volumio-n1 systemd[1]: Failed to start Load Kernel Modules. Apr 21 08:16:21 volumio-n1 systemd[1]: Unit systemd-modules-load.service entered failed state. Apr 21 08:16:21 volumio-n1 kernel: Bluetooth: Core ver 2.18 Apr 21 08:16:21 volumio-n1 kernel: NET: Registered protocol family 31 Apr 21 08:16:21 volumio-n1 kernel: Bluetooth: HCI device and connection manager initialized Apr 21 08:16:21 volumio-n1 kernel: Bluetooth: HCI socket layer initialized Apr 21 08:16:21 volumio-n1 kernel: Bluetooth: L2CAP socket layer initialized Apr 21 08:16:21 volumio-n1 kernel: Bluetooth: SCO socket layer initialized Apr 21 08:16:21 volumio-n1 kernel: Bluetooth: Generic Bluetooth SDIO driver ver 0.1 Apr 21 08:16:21 volumio-n1 systemd[1]: Found device ProductCode BOOT. Apr 21 08:16:21 volumio-n1 systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Apr 21 08:16:21 volumio-n1 systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill3... Apr 21 08:16:21 volumio-n1 systemd[1]: Starting Bluetooth. Apr 21 08:16:21 volumio-n1 systemd[1]: Reached target Bluetooth. Apr 21 08:16:21 volumio-n1 systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill1... Apr 21 08:16:21 volumio-n1 systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill2... Apr 21 08:16:21 volumio-n1 systemd[1]: Starting File System Check on /dev/disk/by-label/BOOT... Apr 21 08:16:21 volumio-n1 systemd[1]: Mounting Configuration File System... Apr 21 08:16:21 volumio-n1 systemd[1]: Starting Apply Kernel Variables... Apr 21 08:16:21 volumio-n1 systemd[1]: Mounted Configuration File System. Apr 21 08:16:21 volumio-n1 systemd[1]: Started Load/Save RF Kill Switch Status of rfkill3. Apr 21 08:16:21 volumio-n1 systemd[1]: Started Apply Kernel Variables. Apr 21 08:16:21 volumio-n1 systemd[1]: Starting LSB: Raise network interfaces.... Apr 21 08:16:21 volumio-n1 systemd-rfkill[4338]: Failed to write system attribute: Invalid argument Apr 21 08:16:21 volumio-n1 systemd[1]: Started Load/Save RF Kill Switch Status of rfkill1. Apr 21 08:16:21 volumio-n1 systemd[1]: systemd-rfkill@rfkill2.service: main process exited, code=exited, status=1/FAILURE Apr 21 08:16:21 volumio-n1 systemd[1]: Failed to start Load/Save RF Kill Switch Status of rfkill2. Apr 21 08:16:21 volumio-n1 systemd[1]: Unit systemd-rfkill@rfkill2.service entered failed state. Apr 21 08:16:22 volumio-n1 systemd[1]: Started File System Check on /dev/disk/by-label/BOOT. Apr 21 08:16:22 volumio-n1 networking[4345]: Configuring network interfaces...command failed: Input/output error (-5) Apr 21 08:16:22 volumio-n1 networking[4345]: command failed: Input/output error (-5) Apr 21 08:16:22 volumio-n1 networking[4345]: command failed: Input/output error (-5) Apr 21 08:16:22 volumio-n1 kernel: dhd_open: Enter ffffffc061be3000 Apr 21 08:16:22 volumio-n1 kernel: Dongle Host Driver, version 1.363.59.144.9 (r) Apr 21 08:16:22 volumio-n1 kernel: wl_android_wifi_on in 1 Apr 21 08:16:22 volumio-n1 kernel: wl_android_wifi_on in 2: g_wifi_on=0 Apr 21 08:16:22 volumio-n1 kernel: wifi_platform_set_power = 1 Apr 21 08:16:22 volumio-n1 kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 08:16:22 volumio-n1 kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 08:16:22 volumio-n1 kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 08:16:22 volumio-n1 kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 08:16:22 volumio-n1 kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 08:16:22 volumio-n1 kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 08:16:23 volumio-n1 kernel: sdio_reset_comm(): Apr 21 08:16:23 volumio-n1 kernel: sdio: clk 200000000 SDR mode tuning start Apr 21 08:16:23 volumio-n1 kernel: sdio: rx_tuning_result[0] = 10 Apr 21 08:16:23 volumio-n1 kernel: sdio: rx_tuning_result[1] = 10 Apr 21 08:16:23 volumio-n1 kernel: sdio: rx_tuning_result[2] = 10 Apr 21 08:16:23 volumio-n1 kernel: sdio: rx_tuning_result[4] = 10 Apr 21 08:16:23 volumio-n1 kernel: sdio: best_win_start =4, best_win_size =4 Apr 21 08:16:23 volumio-n1 kernel: sdio: sd_emmc_regs->gclock=0x1000245,sd_emmc_regs->gadjust=0x12000 Apr 21 08:16:23 volumio-n1 kernel: sdio: gclock =0x1000245, gdelay=0x0, gadjust=0x12000 Apr 21 08:16:23 volumio-n1 kernel: sdioh_start: set sd_f2_blocksize 256 Apr 21 08:16:23 volumio-n1 kernel: dhd_bus_devreset: == WLAN ON == Apr 21 08:16:23 volumio-n1 kernel: F1 signature read @0x18000000=0x15264345 Apr 21 08:16:23 volumio-n1 kernel: F1 signature OK, socitype:0x1 chip:0x4345 rev:0x6 pkg:0x2 Apr 21 08:16:23 volumio-n1 kernel: DHD: dongle ram size is set to 819200(orig 819200) at 0x198000 Apr 21 08:16:23 volumio-n1 kernel: dhd_os_open_image: /lib/firmware/brcm/config.txt (399 bytes) open success Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_others: ccode = SG Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_others: bcn_timeout = 20 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_sdio_params: dhd_slpauto = 1 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_others: mimo_bw_cap = 1 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_pm_params: PM = 0 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=12 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0xa962, chiprev=0, name=nvram_ap6181.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0xa962, chiprev=1, name=nvram_ap6210.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0x4330, chiprev=4, name=nvram_ap6330.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0x4339, chiprev=1, name=nvram_ap6335.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0x4335, chiprev=1, name=nvram_bcm4335.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0xa94c, chiprev=2, name=nvram_ap6234.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_read_nv_by_chip: chip=0x4334, chiprev=3, name=nvram_bcm4334.txt Apr 21 08:16:23 volumio-n1 kernel: Final fw_path=/lib/firmware/brcm/fw_bcm43455c0_ag.bin Apr 21 08:16:23 volumio-n1 kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6255.txt Apr 21 08:16:23 volumio-n1 kernel: Final clm_path=/lib/firmware/brcm/clm_bcmdhd.blob Apr 21 08:16:23 volumio-n1 kernel: Final conf_path=/lib/firmware/brcm/config.txt Apr 21 08:16:23 volumio-n1 kernel: dhd_set_bus_params: set use_rxchain 0 Apr 21 08:16:23 volumio-n1 kernel: dhd_set_bus_params: set txglomsize 36 Apr 21 08:16:23 volumio-n1 kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm43455c0_ag.bin (483181 bytes) open success Apr 21 08:16:23 volumio-n1 kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6255.txt (1644 bytes) open success Apr 21 08:16:23 volumio-n1 kernel: NVRAM version: AP6255_NVRAM_V1.0_29052015 Apr 21 08:16:23 volumio-n1 kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded. Apr 21 08:16:23 volumio-n1 kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us) Apr 21 08:16:23 volumio-n1 kernel: bcmsdh_oob_intr_register: Enter Apr 21 08:16:23 volumio-n1 kernel: bcmsdh_oob_intr_register: HW_OOB enabled Apr 21 08:16:23 volumio-n1 kernel: bcmsdh_oob_intr_register OOB irq=100 flags=0x4 Apr 21 08:16:23 volumio-n1 kernel: bcmsdh_oob_intr_register change flags to 0x4 Apr 21 08:16:23 volumio-n1 kernel: bcmsdh_oob_intr_register: enable_irq_wake Apr 21 08:16:23 volumio-n1 kernel: bcmsdh_oob_intr_register: enable_irq_wake failed with -6 Apr 21 08:16:23 volumio-n1 kernel: Disable tdls_auto_op failed. -1 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_intiovar: set WLC_SET_BAND 142 0 Apr 21 08:16:23 volumio-n1 kernel: dhd_preinit_ioctls: Set tcpack_sup_mode 0 Apr 21 08:16:23 volumio-n1 kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm_bcmdhd.blob Apr 21 08:16:23 volumio-n1 kernel: Firmware up: op_mode=0x0005, MAC=00:90:4c:c5:12:38 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_country: set country SG, revision 0 Apr 21 08:16:23 volumio-n1 kernel: Country code: SG (SG/0) Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_intiovar: set roam_off 1 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_intiovar: set mimo_bw_cap 1 Apr 21 08:16:23 volumio-n1 kernel: Firmware version = wl0: Aug 25 2015 18:58:57 version 7.45.69 (r581703) FWID 01-24037f6e Apr 21 08:16:23 volumio-n1 kernel: Driver: 1.363.59.144.9 (r) Firmware: wl0: Aug 25 2015 18:58:57 version 7.45.69 (r581703) FWID 01-24037f6e Apr 21 08:16:23 volumio-n1 kernel: clm = 7.14.8 Apr 21 08:16:23 volumio-n1 kernel: dhd_txglom_enable: enable 1 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_txglom_params: swtxglom=0, txglom_ext=0, txglom_bucket_size=0 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0, bus_txglom=-1 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_txglom_params: tx_in_rx=1, txinrx_thres=-1, dhd_txminmax=1 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=1 Apr 21 08:16:23 volumio-n1 kernel: sdioh_set_mode: set txglom_mode to multi-desc Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_get_disable_proptx: fw_proptx=1, disable_proptx=-1 Apr 21 08:16:23 volumio-n1 kernel: dhd_wlfc_hostreorder_init(): successful bdcv2 tlv signaling, 64 Apr 21 08:16:23 volumio-n1 kernel: dhd_conf_set_intiovar: set ampdu_hostreorder 1 Apr 21 08:16:23 volumio-n1 kernel: wl_android_wifi_on: Success Apr 21 08:16:23 volumio-n1 kernel: wl_create_event_handler(): thread:wl_event_handler:116e started Apr 21 08:16:23 volumio-n1 kernel: tsk Enter, tsk = 0xffffff80013e2bb8 Apr 21 08:16:24 volumio-n1 kernel: CFG80211-ERROR) wl_update_wiphybands : error reading txbf_bfe_cap (-23) Apr 21 08:16:24 volumio-n1 kernel: CFG80211-ERROR) wl_update_wiphybands : error reading txbf_bfr_cap (-23) Apr 21 08:16:24 volumio-n1 kernel: dhd_open: Exit ret=0 Apr 21 08:16:24 volumio-n1 networking[4345]: done. Apr 21 08:16:24 volumio-n1 systemd[1]: Started LSB: Raise network interfaces.. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting ifup for wlan0... Apr 21 08:16:24 volumio-n1 ifup[4465]: /sbin/ifup: interface wlan0 already configured Apr 21 08:16:24 volumio-n1 systemd[1]: Started ifup for wlan0. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting ifup for eth0... Apr 21 08:16:24 volumio-n1 systemd[1]: Started ifup for eth0. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Network. Apr 21 08:16:24 volumio-n1 systemd[1]: Reached target Network. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Network is Online. Apr 21 08:16:24 volumio-n1 systemd[1]: Reached target Network is Online. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: RPC portmapper replacement... Apr 21 08:16:24 volumio-n1 ifup[4467]: dhcpcd[4482]: version 6.0.5 starting Apr 21 08:16:24 volumio-n1 dhcpcd[4482]: version 6.0.5 starting Apr 21 08:16:24 volumio-n1 dhcpcd[4482]: eth0: soliciting an IPv6 router Apr 21 08:16:24 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: soliciting an IPv6 router Apr 21 08:16:24 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: soliciting a DHCP lease Apr 21 08:16:24 volumio-n1 dhcpcd[4482]: eth0: soliciting a DHCP lease Apr 21 08:16:24 volumio-n1 rpcbind[4478]: Starting rpcbind daemon.... Apr 21 08:16:24 volumio-n1 systemd[1]: Started LSB: RPC portmapper replacement. Apr 21 08:16:24 volumio-n1 dhcpcd[4482]: eth0: carrier lost Apr 21 08:16:24 volumio-n1 systemd[1]: Starting RPC Port Mapper. Apr 21 08:16:24 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: carrier lost Apr 21 08:16:24 volumio-n1 systemd[1]: Reached target RPC Port Mapper. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: NFS support files common to client and server... Apr 21 08:16:24 volumio-n1 rpc.statd[4534]: Version 1.2.8 starting Apr 21 08:16:24 volumio-n1 sm-notify[4535]: Version 1.2.8 starting Apr 21 08:16:24 volumio-n1 kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Apr 21 08:16:24 volumio-n1 nfs-common[4518]: Starting NFS common utilities: statd idmapd. Apr 21 08:16:24 volumio-n1 systemd[1]: Started LSB: NFS support files common to client and server. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting System Initialization. Apr 21 08:16:24 volumio-n1 systemd[1]: Reached target System Initialization. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Apr 21 08:16:24 volumio-n1 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting mpd.socket. Apr 21 08:16:24 volumio-n1 systemd[1]: Listening on mpd.socket. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting D-Bus System Message Bus Socket. Apr 21 08:16:24 volumio-n1 systemd[1]: Listening on D-Bus System Message Bus Socket. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Sockets. Apr 21 08:16:24 volumio-n1 systemd[1]: Reached target Sockets. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Daily Cleanup of Temporary Directories. Apr 21 08:16:24 volumio-n1 systemd[1]: Started Daily Cleanup of Temporary Directories. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Timers. Apr 21 08:16:24 volumio-n1 systemd[1]: Reached target Timers. Apr 21 08:16:24 volumio-n1 systemd[1]: Started Manage Sound Card State (restore and store). Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Restore Sound Card State... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Basic System. Apr 21 08:16:24 volumio-n1 alsactl[4551]: ALSA lib conf.c:1852:(snd_config_load1) _toplevel_:7:0:Unexpected end of file Apr 21 08:16:24 volumio-n1 systemd[1]: Reached target Basic System. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Apr 21 08:16:24 volumio-n1 alsactl[4551]: /usr/sbin/alsactl: load_state:1670: snd_config_load error: Invalid argument Apr 21 08:16:24 volumio-n1 systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting cd.service... Apr 21 08:16:24 volumio-n1 systemd[1]: Started cd.service. Apr 21 08:16:24 volumio-n1 volumio[4554]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Volumio Iptables Module... Apr 21 08:16:24 volumio-n1 systemd[1]: Started Volumio Iptables Module. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting mount disks automatically with standby... Apr 21 08:16:24 volumio-n1 systemd[1]: Started mount disks automatically with standby. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 21 08:16:24 volumio-n1 systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting volumio-remote-updater.service... Apr 21 08:16:24 volumio-n1 systemd[1]: Started volumio-remote-updater.service. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Volumio SSH enabler... Apr 21 08:16:24 volumio-n1 systemd[1]: Started Volumio SSH enabler. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Wireless Services... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Xbindrc... Apr 21 08:16:24 volumio-n1 systemd[1]: Started Xbindrc. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting /etc/rc.local Compatibility... Apr 21 08:16:24 volumio-n1 systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Login Service... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: start Winbind daemon... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: start Samba daemons for the AD DC... Apr 21 08:16:24 volumio-n1 rc.local[4566]: kernel 3.14.29 Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: Start NTP daemon... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: Starts LIRC daemon.... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: Brings up/down network automatically... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting Music Player Daemon... Apr 21 08:16:24 volumio-n1 systemd[1]: Starting D-Bus System Message Bus... Apr 21 08:16:25 volumio-n1 lirc[4588]: No valid /etc/lirc/lircd.conf has been found.. Apr 21 08:16:25 volumio-n1 lirc[4588]: Remote control support has been disabled.. Apr 21 08:16:25 volumio-n1 lirc[4588]: Reconfigure LIRC or manually replace /etc/lirc/lircd.conf to enable.. Apr 21 08:16:25 volumio-n1 dhcpcd[4603]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Apr 21 08:16:25 volumio-n1 dhcpcd[4603]: /var/run/dhcpcd-eth0.pid ... failed! Apr 21 08:16:25 volumio-n1 kernel: fb: osd[0] canvas.idx =0x40 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[0] canvas.addr=0x7d100000 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[0] canvas.width=3840 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[0] canvas.height=1440 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[0] frame.width=1280 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[0] frame.height=720 Apr 21 08:16:25 volumio-n1 kernel: fb: Frame buffer memory assigned at Apr 21 08:16:25 volumio-n1 kernel: fb: 1, phy: 0x000000007e900000, vir:0xffffff8003600000, size=1024K Apr 21 08:16:25 volumio-n1 kernel: fb: fb1 open, logo index:1 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[1] canvas.idx =0x43 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[1] canvas.addr=0x7e900000 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[1] canvas.width=128 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[1] canvas.height=32 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[1] frame.width=32 Apr 21 08:16:25 volumio-n1 kernel: fb: osd[1] frame.height=32 Apr 21 08:16:25 volumio-n1 ifplugd(eth0)[4650]: ifplugd 0.28 initializing. Apr 21 08:16:25 volumio-n1 ifplugd(eth0)[4650]: Using interface eth0/00:AC:2F:79:C0:FF with driver (version: March_2013) Apr 21 08:16:25 volumio-n1 ifplugd(eth0)[4650]: Using detection mode: SIOCETHTOOL Apr 21 08:16:25 volumio-n1 ifplugd(eth0)[4650]: Initialization complete, link beat not detected. Apr 21 08:16:25 volumio-n1 systemd[1]: Started D-Bus System Message Bus. Apr 21 08:16:25 volumio-n1 kernel: vout_serve: vmode set to 720p60hz Apr 21 08:16:25 volumio-n1 kernel: fb: current vmode=1080p60hz, cmd: 0x50000 Apr 21 08:16:25 volumio-n1 kernel: tv_vout: tv_set_current_vmode[919]fps_target_mode=10 Apr 21 08:16:25 volumio-n1 kernel: tv_vout: mode is 10,sync_duration_den=1,sync_duration_num=60 Apr 21 08:16:25 volumio-n1 loadcpufreq[4585]: Loading cpufreq kernel modules...done (none). Apr 21 08:16:25 volumio-n1 kernel: tv_vout: TV mode 720p60hz selected. Apr 21 08:16:25 volumio-n1 kernel: vdac_enable: on:0,module_sel:8 Apr 21 08:16:25 volumio-n1 kernel: vdac_enable: on:0,module_sel:8 Apr 21 08:16:25 volumio-n1 kernel: tv_vout: new mode =720p60hz set ok Apr 21 08:16:25 volumio-n1 kernel: vout_serve: vinfo mode is: 720p60hz Apr 21 08:16:25 volumio-n1 kernel: vout_serve: new mode 720p60hz set ok Apr 21 08:16:25 volumio-n1 kernel: hdmitx: video: get current mode: 720p60hz Apr 21 08:16:25 volumio-n1 kernel: hdmitx: update rx hdr info 0 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: update physcial size: 600 330 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: system: already init VIC = 0 Now VIC = 4 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: rx no SCDC present indicator Apr 21 08:16:25 volumio-n1 kernel: hdmitx: ddc rd8b error 0x54 0x01 Apr 21 08:16:25 volumio-n1 ifplugd[4598]: Network Interface Plugging Daemon...start eth0...done. Apr 21 08:16:25 volumio-n1 kernel: hdmitx: ddc rd8b error 0x54 0x01 Apr 21 08:16:25 volumio-n1 kernel: hdmirx version is 1.4 or below Apr 21 08:16:25 volumio-n1 kernel: hdmitx div40: 0 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: system: set mode VIC 4 (cd0,cs0,pm1,vd0,1) Apr 21 08:16:25 volumio-n1 kernel: hdmitx: system: set pll Apr 21 08:16:25 volumio-n1 kernel: hdmitx: system: param->VIC:4 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: ddc w1b error 0x54 0x20 0x00 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: ddc w1b error 0x54 0x20 0x00 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: ddc rd8b error 0x54 0x21 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: set clk: VIC = 4 cd = 4 frac_rate = 0 Apr 21 08:16:25 volumio-n1 ntpd[4633]: ntpd 4.2.6p5@1.2349-o Fri Jul 22 17:59:22 UTC 2016 (1) Apr 21 08:16:25 volumio-n1 ntpd[4659]: proto: precision = 0.416 usec Apr 21 08:16:25 volumio-n1 ntpd[4659]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 21 08:16:25 volumio-n1 ntp[4577]: Starting NTP server: ntpd. Apr 21 08:16:25 volumio-n1 ntpd[4659]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 21 08:16:25 volumio-n1 ntpd[4659]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 21 08:16:25 volumio-n1 ntpd[4659]: peers refreshed Apr 21 08:16:25 volumio-n1 ntpd[4659]: Listening on routing socket on fd #19 for interface updates Apr 21 08:16:25 volumio-n1 kernel: config HPLL = 2970000 Apr 21 08:16:25 volumio-n1 kernel: HPLL: 0xc000027b Apr 21 08:16:25 volumio-n1 kernel: config HPLL done Apr 21 08:16:25 volumio-n1 kernel: set_hpll_od3_clk_div[437] div = 6 Apr 21 08:16:25 volumio-n1 kernel: j = 2 vid_clk_div = 1 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: set enc for VIC: 4 Apr 21 08:16:25 volumio-n1 kernel: hdmitx_set_hw[4947] set VIC = 4 Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Successfully dropped root privileges. Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: avahi-daemon 0.6.31 starting up. Apr 21 08:16:25 volumio-n1 dhcpcd[4482]: eth0: carrier acquired Apr 21 08:16:25 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: carrier acquired Apr 21 08:16:25 volumio-n1 kernel: libphy: stmmac-0:00 - Link is Up - 100/Full Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Successfully called chroot(). Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Successfully dropped remaining capabilities. Apr 21 08:16:25 volumio-n1 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 21 08:16:25 volumio-n1 dhcpcd[4482]: eth0: soliciting an IPv6 router Apr 21 08:16:25 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: soliciting an IPv6 router Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Loading service file /services/volumio.service. Apr 21 08:16:25 volumio-n1 systemd[1]: Starting Permit User Sessions... Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Network interface enumeration completed. Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Registering HINFO record with values 'AARCH64'/'LINUX'. Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Server startup complete. Host name is volumio-n1.local. Local service cookie is 4082334610. Apr 21 08:16:25 volumio-n1 avahi-daemon[4606]: Service "Volumio-N1" (/services/volumio.service) successfully established. Apr 21 08:16:25 volumio-n1 systemd[1]: Started Restore Sound Card State. Apr 21 08:16:25 volumio-n1 systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 08:16:25 volumio-n1 systemd[1]: Unit cd.service entered failed state. Apr 21 08:16:25 volumio-n1 kernel: hdmitx: system: PHY Setting Done Apr 21 08:16:25 volumio-n1 kernel: hdmitx: system: irq 80000001 Apr 21 08:16:25 volumio-n1 kernel: Start = 0x10000100 End = 0x100001ff Apr 21 08:16:25 volumio-n1 kernel: Sink is HDMI device Apr 21 08:16:25 volumio-n1 kernel: hdmitx: system: packet: can't get vendor data Apr 21 08:16:25 volumio-n1 kernel: 720p60hz 60 1 Apr 21 08:16:25 volumio-n1 kernel: 720p60hz 60 1 Apr 21 08:16:25 volumio-n1 kernel: hdmtix: set audio Apr 21 08:16:25 volumio-n1 kernel: hdmitx tx_aud_src = 0 Apr 21 08:16:25 volumio-n1 kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 74250 Apr 21 08:16:25 volumio-n1 kernel: hdmitx aud_n_para = 6144 Apr 21 08:16:25 volumio-n1 kernel: hdmitx set channel status Apr 21 08:16:25 volumio-n1 kernel: hdmitx: audio: Audio Type: PCM Apr 21 08:16:25 volumio-n1 kernel: fb: current vmode=720p60hz, cmd: 0x10000 Apr 21 08:16:25 volumio-n1 kernel: [0x10000104]: 0x00000001 Apr 21 08:16:25 volumio-n1 kernel: [0x10000180]: 0x000000ff Apr 21 08:16:25 volumio-n1 kernel: [0x10000181]: 0x000000ff Apr 21 08:16:25 volumio-n1 kernel: [0x10000182]: 0x00000003 Apr 21 08:16:25 volumio-n1 kernel: [0x10000183]: 0x00000007 Apr 21 08:16:25 volumio-n1 kernel: [0x10000184]: 0x0000003f Apr 21 08:16:25 volumio-n1 kernel: [0x10000185]: 0x00000002 Apr 21 08:16:25 volumio-n1 kernel: [0x10000187]: 0x000000ff Apr 21 08:16:25 volumio-n1 kernel: [0x10000188]: 0x00000003 Apr 21 08:16:25 volumio-n1 dhcpcd[4482]: eth0: soliciting a DHCP lease Apr 21 08:16:25 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: soliciting a DHCP lease Apr 21 08:16:25 volumio-n1 systemd[1]: Started /etc/rc.local Compatibility. Apr 21 08:16:25 volumio-n1 systemd[1]: Started LSB: Start NTP daemon. Apr 21 08:16:25 volumio-n1 kernel: fb: osd[0] enable: 1 (hdmi.sh) Apr 21 08:16:25 volumio-n1 kernel: fb: osd[1] enable: 0 (hdmi.sh) Apr 21 08:16:25 volumio-n1 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 21 08:16:25 volumio-n1 systemd[1]: Started LSB: Starts LIRC daemon.. Apr 21 08:16:25 volumio-n1 systemd[1]: Started LSB: Brings up/down network automatically. Apr 21 08:16:25 volumio-n1 systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Apr 21 08:16:25 volumio-n1 systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Apr 21 08:16:25 volumio-n1 systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Apr 21 08:16:25 volumio-n1 systemd[1]: Unit dhcpcd.service entered failed state. Apr 21 08:16:25 volumio-n1 systemd[1]: Started Permit User Sessions. Apr 21 08:16:25 volumio-n1 systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 08:16:25 volumio-n1 systemd[1]: Stopping cd.service... Apr 21 08:16:25 volumio-n1 systemd-logind[4569]: New seat seat0. Apr 21 08:16:25 volumio-n1 systemd[1]: Starting cd.service... Apr 21 08:16:25 volumio-n1 systemd[1]: Started cd.service. Apr 21 08:16:25 volumio-n1 systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 21 08:16:25 volumio-n1 systemd[1]: Starting Wait for Plymouth Boot Screen to Quit... Apr 21 08:16:25 volumio-n1 systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 21 08:16:25 volumio-n1 volumio[4683]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 08:16:25 volumio-n1 systemd[1]: Started Login Service. Apr 21 08:16:25 volumio-n1 systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 08:16:25 volumio-n1 systemd[1]: Unit cd.service entered failed state. Apr 21 08:16:25 volumio-n1 systemd[1]: Started Terminate Plymouth Boot Screen. Apr 21 08:16:25 volumio-n1 systemd[1]: Started Wait for Plymouth Boot Screen to Quit. Apr 21 08:16:25 volumio-n1 systemd[1]: Starting Getty on tty1... Apr 21 08:16:25 volumio-n1 systemd[1]: Started Getty on tty1. Apr 21 08:16:25 volumio-n1 systemd[1]: Starting Serial Getty on ttyS0... Apr 21 08:16:25 volumio-n1 systemd[1]: Started Serial Getty on ttyS0. Apr 21 08:16:25 volumio-n1 systemd[1]: Starting Login Prompts. Apr 21 08:16:25 volumio-n1 systemd[1]: Reached target Login Prompts. Apr 21 08:16:25 volumio-n1 cpufrequtils[4684]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Apr 21 08:16:25 volumio-n1 systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 21 08:16:25 volumio-n1 haveged[4553]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Apr 21 08:16:25 volumio-n1 haveged[4553]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 9/40; sz: 15780/68380 Apr 21 08:16:25 volumio-n1 haveged[4553]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99843 Apr 21 08:16:25 volumio-n1 haveged[4553]: haveged: fills: 0, generated: 0 Apr 21 08:16:25 volumio-n1 sudo[4565]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Apr 21 08:16:25 volumio-n1 sudo[4565]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:25 volumio-n1 sudo[4565]: pam_unix(sudo:session): session closed for user root Apr 21 08:16:25 volumio-n1 systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 08:16:25 volumio-n1 systemd[1]: Stopping cd.service... Apr 21 08:16:25 volumio-n1 systemd[1]: Starting cd.service... Apr 21 08:16:25 volumio-n1 systemd[1]: Started cd.service. Apr 21 08:16:25 volumio-n1 volumio[4707]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 08:16:25 volumio-n1 systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 08:16:25 volumio-n1 dbus[4634]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Apr 21 08:16:25 volumio-n1 systemd[1]: Unit cd.service entered failed state. Apr 21 08:16:25 volumio-n1 systemd[1]: Starting Disk Manager (legacy version)... Apr 21 08:16:26 volumio-n1 ifplugd(eth0)[4650]: Link beat detected. Apr 21 08:16:26 volumio-n1 systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 08:16:26 volumio-n1 systemd[1]: Stopping cd.service... Apr 21 08:16:26 volumio-n1 ifplugd(eth0)[4650]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Apr 21 08:16:26 volumio-n1 dbus[4634]: [system] Successfully activated service 'org.freedesktop.UDisks' Apr 21 08:16:26 volumio-n1 systemd[1]: Starting cd.service... Apr 21 08:16:26 volumio-n1 systemd[1]: Started cd.service. Apr 21 08:16:26 volumio-n1 volumio[4712]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 08:16:26 volumio-n1 systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 08:16:26 volumio-n1 systemd[1]: Unit cd.service entered failed state. Apr 21 08:16:26 volumio-n1 ifplugd(eth0)[4650]: client: /sbin/ifup: interface eth0 already configured Apr 21 08:16:26 volumio-n1 systemd[1]: Started Disk Manager (legacy version). Apr 21 08:16:26 volumio-n1 ifplugd(eth0)[4650]: Program executed successfully. Apr 21 08:16:26 volumio-n1 systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 08:16:26 volumio-n1 systemd[1]: Stopping cd.service... Apr 21 08:16:26 volumio-n1 dbus[4634]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Apr 21 08:16:26 volumio-n1 systemd[1]: Starting cd.service... Apr 21 08:16:26 volumio-n1 systemd[1]: Started cd.service. Apr 21 08:16:26 volumio-n1 volumio[4719]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 08:16:26 volumio-n1 systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 08:16:26 volumio-n1 systemd[1]: Unit cd.service entered failed state. Apr 21 08:16:26 volumio-n1 systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Apr 21 08:16:26 volumio-n1 volumio-remote-updater[4559]: Error: No active session Apr 21 08:16:26 volumio-n1 volumio-remote-updater[4559]: [2025-04-21 08:16:26] [info] asio async_connect error: system:111 (Connection refused) Apr 21 08:16:26 volumio-n1 volumio-remote-updater[4559]: [2025-04-21 08:16:26] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 21 08:16:26 volumio-n1 volumio-remote-updater[4559]: [2025-04-21 08:16:26] [error] handle_connect error: Underlying Transport Error Apr 21 08:16:26 volumio-n1 polkitd[4721]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 21 08:16:26 volumio-n1 dbus[4634]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 21 08:16:26 volumio-n1 systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 08:16:26 volumio-n1 systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Apr 21 08:16:26 volumio-n1 systemd[1]: Stopping cd.service... Apr 21 08:16:26 volumio-n1 systemd[1]: Starting cd.service... Apr 21 08:16:26 volumio-n1 systemd[1]: cd.service start request repeated too quickly, refusing to start. Apr 21 08:16:26 volumio-n1 systemd[1]: Failed to start cd.service. Apr 21 08:16:26 volumio-n1 systemd[1]: Unit cd.service entered failed state. Apr 21 08:16:26 volumio-n1 volumio[4558]: Could not open config: /tmp/upmpdcli.conf Apr 21 08:16:26 volumio-n1 systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Apr 21 08:16:26 volumio-n1 systemd[1]: Unit upmpdcli.service entered failed state. Apr 21 08:16:26 volumio-n1 udisks-glue[4557]: Device file /dev/sda3 inserted Apr 21 08:16:26 volumio-n1 udisks-glue[4557]: Device file /dev/sda inserted Apr 21 08:16:26 volumio-n1 udisks-glue[4557]: Device file /dev/misc inserted Apr 21 08:16:26 volumio-n1 udisks-glue[4557]: Device file /dev/mmcblk0rpmb inserted Apr 21 08:16:26 volumio-n1 udisks-glue[4557]: Device file /dev/bootloader inserted Apr 21 08:16:26 volumio-n1 udisks-glue[4557]: Device file /dev/tee inserted Apr 21 08:16:26 volumio-n1 udisks-glue[4557]: Trying to automount /dev/tee... Apr 21 08:16:27 volumio-n1 kernel: EXT4-fs (mmcblk0p8): mounted filesystem with ordered data mode. Opts: (null) Apr 21 08:16:27 volumio-n1 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 21 08:16:27 volumio-n1 systemd[1]: Stopping Xbindrc... Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Successfully automounted /dev/tee at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b Apr 21 08:16:27 volumio-n1 systemd[1]: Starting Xbindrc... Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/logo inserted Apr 21 08:16:27 volumio-n1 ntpd[4659]: Deferring DNS for 0.debian.pool.ntp.org 1 Apr 21 08:16:27 volumio-n1 systemd[1]: Started Xbindrc. Apr 21 08:16:27 volumio-n1 ntpd[4659]: Deferring DNS for 1.debian.pool.ntp.org 1 Apr 21 08:16:27 volumio-n1 ntpd[4659]: Deferring DNS for 2.debian.pool.ntp.org 1 Apr 21 08:16:27 volumio-n1 ntpd[4659]: Deferring DNS for 3.debian.pool.ntp.org 1 Apr 21 08:16:27 volumio-n1 ntpd[4738]: signal_no_reset: signal 17 had flags 4000000 Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/env inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/boot inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/mmcblk0boot0 inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/mmcblk0boot1 inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/recovery inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/system inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Trying to automount /dev/system... Apr 21 08:16:27 volumio-n1 kernel: EXT4-fs (mmcblk0p12): mounted filesystem with ordered data mode. Opts: (null) Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Successfully automounted /dev/system at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_ Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/rsv inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/cache inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Trying to automount /dev/cache... Apr 21 08:16:27 volumio-n1 kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Apr 21 08:16:27 volumio-n1 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 21 08:16:27 volumio-n1 systemd[1]: Stopping Xbindrc... Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Successfully automounted /dev/cache at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b__ Apr 21 08:16:27 volumio-n1 systemd[1]: Starting Xbindrc... Apr 21 08:16:27 volumio-n1 systemd[1]: Started Xbindrc. Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/reserved inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/crypt inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/mmcblk0 inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/data inserted Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Trying to automount /dev/data... Apr 21 08:16:27 volumio-n1 kernel: EXT4-fs (mmcblk0p13): mounted filesystem with ordered data mode. Opts: (null) Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Successfully automounted /dev/data at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b___ Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/tee mounted at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/system mounted at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_ Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/cache mounted at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b__ Apr 21 08:16:27 volumio-n1 udisks-glue[4557]: Device file /dev/data mounted at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b___ Apr 21 08:16:27 volumio-n1 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 21 08:16:27 volumio-n1 systemd[1]: Stopping Xbindrc... Apr 21 08:16:27 volumio-n1 systemd[1]: Starting Xbindrc... Apr 21 08:16:27 volumio-n1 systemd[1]: Started Xbindrc. Apr 21 08:16:28 volumio-n1 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 21 08:16:28 volumio-n1 systemd[1]: Stopping Xbindrc... Apr 21 08:16:28 volumio-n1 systemd[1]: Starting Xbindrc... Apr 21 08:16:28 volumio-n1 systemd[1]: Started Xbindrc. Apr 21 08:16:28 volumio-n1 dhcpcd[4482]: eth0: offered 192.168.123.183 from 192.168.123.1 Apr 21 08:16:28 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: offered 192.168.123.183 from 192.168.123.1 Apr 21 08:16:28 volumio-n1 systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 21 08:16:28 volumio-n1 systemd[1]: Stopping Xbindrc... Apr 21 08:16:28 volumio-n1 systemd[1]: Starting Xbindrc... Apr 21 08:16:28 volumio-n1 wireless.js[4705]: WIRELESS DAEMON: start Apr 21 08:16:28 volumio-n1 systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. Apr 21 08:16:28 volumio-n1 systemd[1]: Failed to start Xbindrc. Apr 21 08:16:28 volumio-n1 systemd[1]: Unit xbindkeysrc.service entered failed state. Apr 21 08:16:28 volumio-n1 wireless.js[4705]: WIRELESS: Loaded configuration Apr 21 08:16:28 volumio-n1 wireless.js[4705]: Cleaning previous... Apr 21 08:16:28 volumio-n1 systemd[1]: Stopped hotspot.service. Apr 21 08:16:28 volumio-n1 sudo[4784]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 08:16:28 volumio-n1 sudo[4784]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:28 volumio-n1 sudo[4784]: pam_unix(sudo:session): session closed for user root Apr 21 08:16:28 volumio-n1 sudo[4786]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 08:16:28 volumio-n1 sudo[4786]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:28 volumio-n1 kernel: dhd_stop: Enter ffffffc061be3000 Apr 21 08:16:29 volumio-n1 kernel: wl_event_handler: was terminated Apr 21 08:16:29 volumio-n1 kernel: wl_destroy_event_handler(): thread:wl_event_handler:116e terminated OK Apr 21 08:16:29 volumio-n1 kernel: CFGP2P-ERROR) wl_cfgp2p_disable_discovery : do nothing, not initialized Apr 21 08:16:29 volumio-n1 kernel: CFGP2P-ERROR) wl_cfgp2p_deinit_priv : In Apr 21 08:16:29 volumio-n1 kernel: wl_android_wifi_off in 1 Apr 21 08:16:29 volumio-n1 kernel: wl_android_wifi_off in 2: g_wifi_on=1, on_failure=1 Apr 21 08:16:29 volumio-n1 kernel: bcmsdh_oob_intr_unregister: Enter Apr 21 08:16:29 volumio-n1 kernel: dhd_txglom_enable: enable 0 Apr 21 08:16:29 volumio-n1 kernel: dhd_conf_set_txglom_params: swtxglom=0, txglom_ext=0, txglom_bucket_size=0 Apr 21 08:16:29 volumio-n1 ntpd_intres[4738]: host name not found: 0.debian.pool.ntp.org Apr 21 08:16:29 volumio-n1 ntpd_intres[4738]: host name not found: 1.debian.pool.ntp.org Apr 21 08:16:29 volumio-n1 ntpd_intres[4738]: host name not found: 2.debian.pool.ntp.org Apr 21 08:16:29 volumio-n1 ntpd_intres[4738]: host name not found: 3.debian.pool.ntp.org Apr 21 08:16:29 volumio-n1 kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0, bus_txglom=-1 Apr 21 08:16:29 volumio-n1 kernel: dhd_conf_set_txglom_params: tx_in_rx=1, txinrx_thres=-1, dhd_txminmax=1 Apr 21 08:16:29 volumio-n1 kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=1 Apr 21 08:16:29 volumio-n1 kernel: sdioh_set_mode: set txglom_mode to multi-desc Apr 21 08:16:29 volumio-n1 kernel: dhd_bus_devreset: WLAN OFF DONE Apr 21 08:16:29 volumio-n1 kernel: wifi_platform_set_power = 0 Apr 21 08:16:29 volumio-n1 kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 08:16:29 volumio-n1 kernel: wl_android_wifi_off out Apr 21 08:16:29 volumio-n1 systemd[1]: Started LSB: start Samba daemons for the AD DC. Apr 21 08:16:29 volumio-n1 sudo[4786]: pam_unix(sudo:session): session closed for user root Apr 21 08:16:29 volumio-n1 kernel: dhd_stop: Exit Apr 21 08:16:29 volumio-n1 wireless.js[4705]: Stopped aP Apr 21 08:16:29 volumio-n1 wireless.js[4705]: Wireless Networking DISABLED, not starting wireless flow Apr 21 08:16:29 volumio-n1 systemd[1]: Started Wireless Services. Apr 21 08:16:29 volumio-n1 systemd[1]: Starting Volumio Backend Module... Apr 21 08:16:29 volumio-n1 systemd[1]: Started Volumio Backend Module. Apr 21 08:16:29 volumio-n1 systemd[1]: Starting Volumio Streaming Daemon... Apr 21 08:16:29 volumio-n1 systemd[1]: Started Volumio Streaming Daemon. Apr 21 08:16:29 volumio-n1 nmbd[4580]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 08:16:29 volumio-n1 nmbd[4580]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 08:16:29 volumio-n1 nmbd[4580]: Unable to setup corepath for nmbd: No such file or directory Apr 21 08:16:29 volumio-n1 nmbd[4580]: [2025/04/21 08:16:29, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:29 volumio-n1 nmbd[4580]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 08:16:29 volumio-n1 nmbd[4580]: [2025/04/21 08:16:29, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:29 volumio-n1 nmbd[4580]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 08:16:29 volumio-n1 nmbd[4801]: [2025/04/21 08:16:29.411959, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:29 volumio-n1 nmbd[4801]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 08:16:29 volumio-n1 nmbd[4580]: [2025/04/21 08:16:29, 0] ../source3/nmbd/nmbd.c:908(main) Apr 21 08:16:29 volumio-n1 nmbd[4580]: nmbd version 4.2.14-Debian started. Apr 21 08:16:29 volumio-n1 nmbd[4580]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 21 08:16:29 volumio-n1 nmbd[4580]: [2025/04/21 08:16:29.411959, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:29 volumio-n1 nmbd[4580]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 08:16:29 volumio-n1 nmbd[4580]: failed! Apr 21 08:16:29 volumio-n1 systemd[1]: nmbd.service: control process exited, code=exited status=1 Apr 21 08:16:29 volumio-n1 systemd[1]: Failed to start LSB: start Samba NetBIOS nameserver (nmbd). Apr 21 08:16:29 volumio-n1 systemd[1]: Unit nmbd.service entered failed state. Apr 21 08:16:29 volumio-n1 systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Apr 21 08:16:29 volumio-n1 winbind[4571]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 08:16:29 volumio-n1 winbind[4571]: Unable to setup corepath for winbindd: No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 08:16:29 volumio-n1 winbind[4571]: Unable to setup corepath for winbindd: No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:29 volumio-n1 winbind[4571]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:29 volumio-n1 winbind[4571]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../source3/winbindd/winbindd.c:1549(main) Apr 21 08:16:29 volumio-n1 winbind[4571]: winbindd version 4.2.14-Debian started. Apr 21 08:16:29 volumio-n1 winbind[4571]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../lib/util/util.c:220(directory_create_or_exist) Apr 21 08:16:29 volumio-n1 winbind[4571]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Apr 21 08:16:29 volumio-n1 winbind[4571]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Apr 21 08:16:29 volumio-n1 winbind[4571]: Unable to setup corepath for winbindd: No such file or directory Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../source3/lib/util.c:788(smb_panic_s3) Apr 21 08:16:29 volumio-n1 winbind[4571]: PANIC (pid 4797): Could not init winbindd's messaging context. Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../source3/lib/util.c:899(log_stack_trace) Apr 21 08:16:29 volumio-n1 winbind[4571]: BACKTRACE: 0 stack frames: Apr 21 08:16:29 volumio-n1 winbind[4571]: [2025/04/21 08:16:29, 0] ../source3/lib/dumpcore.c:304(dump_core) Apr 21 08:16:29 volumio-n1 winbind[4571]: Can not dump core: corepath not set up Apr 21 08:16:29 volumio-n1 systemd[1]: winbind.service: control process exited, code=exited status=1 Apr 21 08:16:29 volumio-n1 systemd[1]: Failed to start LSB: start Winbind daemon. Apr 21 08:16:29 volumio-n1 systemd[1]: Unit winbind.service entered failed state. Apr 21 08:16:29 volumio-n1 winbind[4571]: failed! Apr 21 08:16:29 volumio-n1 volumio-streaming-daemon[4806]: ############################ Apr 21 08:16:29 volumio-n1 volumio-streaming-daemon[4806]: # Volumio Streaming Daemon # Apr 21 08:16:29 volumio-n1 volumio-streaming-daemon[4806]: # Running on port 7777 # Apr 21 08:16:29 volumio-n1 volumio-streaming-daemon[4806]: ############################ Apr 21 08:16:29 volumio-n1 systemd[1]: Started Music Player Daemon. Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: Updating DB (#1) ... Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: volume: n/a repeat: off random: off single: off consume: off Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: Updating DB (#1) ... Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: volume: n/a repeat: off random: off single: off consume: off Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: Updating DB (#1) ... Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: volume: n/a repeat: off random: off single: off consume: off Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: Updating DB (#1) ... Apr 21 08:16:29 volumio-n1 udisks-glue[4557]: volume: n/a repeat: off random: off single: off consume: off Apr 21 08:16:30 volumio-n1 smbd[4817]: Starting SMB/CIFS daemon: smbd[2025/04/21 08:16:30, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:30 volumio-n1 smbd[4817]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 21 08:16:30 volumio-n1 smbd[4817]: [2025/04/21 08:16:30, 0] ../lib/util/util.c:220(directory_create_or_exist) Apr 21 08:16:30 volumio-n1 smbd[4817]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 08:16:30 volumio-n1 smbd[4817]: [2025/04/21 08:16:30, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Apr 21 08:16:30 volumio-n1 smbd[4817]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 08:16:30 volumio-n1 smbd[4817]: [2025/04/21 08:16:30, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Apr 21 08:16:30 volumio-n1 smbd[4817]: Unable to setup corepath for smbd: No such file or directory Apr 21 08:16:30 volumio-n1 smbd[4817]: [2025/04/21 08:16:30, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 08:16:30 volumio-n1 smbd[4817]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 21 08:16:30 volumio-n1 smbd[4817]: [2025/04/21 08:16:30, 0] ../source3/smbd/server.c:1241(main) Apr 21 08:16:30 volumio-n1 smbd[4817]: smbd version 4.2.14-Debian started. Apr 21 08:16:30 volumio-n1 smbd[4817]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 21 08:16:30 volumio-n1 smbd[4817]: failed! Apr 21 08:16:30 volumio-n1 systemd[1]: smbd.service: control process exited, code=exited status=1 Apr 21 08:16:30 volumio-n1 systemd[1]: Failed to start LSB: start Samba SMB/CIFS daemon (smbd). Apr 21 08:16:30 volumio-n1 systemd[1]: Unit smbd.service entered failed state. Apr 21 08:16:30 volumio-n1 systemd[1]: Starting Multi-User System. Apr 21 08:16:30 volumio-n1 systemd[1]: Reached target Multi-User System. Apr 21 08:16:30 volumio-n1 systemd[1]: Starting Graphical Interface. Apr 21 08:16:30 volumio-n1 systemd[1]: Reached target Graphical Interface. Apr 21 08:16:30 volumio-n1 systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 21 08:16:30 volumio-n1 systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 21 08:16:30 volumio-n1 kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 08:16:30 volumio-n1 systemd[1]: Startup finished in 16.081s (kernel) + 11.561s (userspace) = 27.643s. Apr 21 08:16:30 volumio-n1 kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 08:16:30 volumio-n1 kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 08:16:30 volumio-n1 kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 08:16:31 volumio-n1 volumio-remote-updater[4559]: [2025-04-21 08:16:31] [connect] Successful connection Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ------------------------------------------- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ----- Volumio2 ---- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ------------------------------------------- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ----- System startup ---- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ------------------------------------------- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: MYVOLUMIO Environment detected Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin music_service/airplay_emulation. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin music_service/inputs. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin music_service/mpd. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin music_service/webradio. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin music_service/example_plugin. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin music_service/last_100. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin music_service/upnp_browser. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin audio_interface/outputs. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin audio_interface/upnp. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin audio_interface/alsa_controller. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin miscellanea/alarm-clock. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin miscellanea/albumart. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin miscellanea/appearance. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin miscellanea/wizard. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin miscellanea/my_music. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin user_interface/websocket. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin user_interface/mpdemulation. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin user_interface/rest_api. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/updater_comm. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/network. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/networkfs. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/services. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/system. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/i2s_dacs. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/volumiodiscovery. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Found new core plugin system_controller/volumio_command_line_client. Adding it Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Plugin folders cleanup Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning into folder /volumio/app/plugins/ Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning category audio_interface Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning category miscellanea Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning category music_service Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning category plugins.json Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning category system_controller Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning category user_interface Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Scanning into folder /data/plugins/ Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Plugin folders cleanup completed Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ------------------------------------------- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ----- Core plugins startup ---- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: ------------------------------------------- Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Loading plugins from folder /volumio/app/plugins/ Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Adding plugin upnp to MyMusic Plugins Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Loading plugins from folder /data/plugins/ Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Loading plugin "system"... Apr 21 08:16:32 volumio-n1 volumio[4805]: No id defined. Creating one Apr 21 08:16:32 volumio-n1 volumio[4805]: info: Loading plugin "appearance"... Apr 21 08:16:33 volumio-n1 volumio[4805]: info: Loading plugin "network"... Apr 21 08:16:34 volumio-n1 dhcpcd[4482]: eth0: leased 192.168.123.183 for 86400 seconds Apr 21 08:16:34 volumio-n1 dhcpcd[4482]: eth0: adding host route to 192.168.123.183 via 127.0.0.1 Apr 21 08:16:34 volumio-n1 dhcpcd[4482]: eth0: adding route to 192.168.123.0/24 Apr 21 08:16:34 volumio-n1 dhcpcd[4482]: eth0: adding default route via 192.168.123.1 Apr 21 08:16:34 volumio-n1 avahi-daemon[4606]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.123.183. Apr 21 08:16:34 volumio-n1 avahi-daemon[4606]: New relevant interface eth0.IPv4 for mDNS. Apr 21 08:16:34 volumio-n1 avahi-daemon[4606]: Registering new address record for 192.168.123.183 on eth0.IPv4. Apr 21 08:16:34 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: leased 192.168.123.183 for 86400 seconds Apr 21 08:16:34 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: adding host route to 192.168.123.183 via 127.0.0.1 Apr 21 08:16:34 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: adding route to 192.168.123.0/24 Apr 21 08:16:34 volumio-n1 ifup[4467]: dhcpcd[4482]: eth0: adding default route via 192.168.123.1 Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "services"... Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "alsa_controller"... Apr 21 08:16:34 volumio-n1 dhcpcd[4482]: forked to background, child pid 4875 Apr 21 08:16:34 volumio-n1 ifup[4467]: dhcpcd[4482]: forked to background, child pid 4875 Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "wizard"... Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "volumio_command_line_client"... Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "upnp"... Apr 21 08:16:34 volumio-n1 volumio[4805]: info: [1745223394313] Starting Upmpd Daemon Apr 21 08:16:34 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "my_music"... Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "mpd"... Apr 21 08:16:34 volumio-n1 volumio[4805]: info: Loading plugin "upnp_browser"... Apr 21 08:16:35 volumio-n1 ntpd[4659]: Listen normally on 3 eth0 192.168.123.183 UDP 123 Apr 21 08:16:35 volumio-n1 ntpd[4659]: peers refreshed Apr 21 08:16:35 volumio-n1 volumio[4805]: info: Loading plugin "networkfs"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "alarm-clock"... Apr 21 08:16:36 volumio-n1 sudo[4936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=xkxiaoli,password=Stone198568,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.68/music /mnt/NAS/飞牛 Apr 21 08:16:36 volumio-n1 sudo[4936]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "airplay_emulation"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Starting Shairport Sync Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "last_100"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "webradio"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "i2s_dacs"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: I2S DAC not set, start Auto-detection Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "volumiodiscovery"... Apr 21 08:16:36 volumio-n1 volumio[4805]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 08:16:36 volumio-n1 node[4805]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 08:16:36 volumio-n1 node[4805]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 08:16:36 volumio-n1 node[4805]: *** WARNING *** For more information see Apr 21 08:16:36 volumio-n1 node[4805]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 08:16:36 volumio-n1 node[4805]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 08:16:36 volumio-n1 node[4805]: *** WARNING *** For more information see Apr 21 08:16:36 volumio-n1 volumio[4805]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 08:16:36 volumio-n1 volumio[4805]: *** WARNING *** For more information see Apr 21 08:16:36 volumio-n1 volumio[4805]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 08:16:36 volumio-n1 volumio[4805]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 08:16:36 volumio-n1 volumio[4805]: *** WARNING *** For more information see Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 21 08:16:36 volumio-n1 volumio[4805]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/volumiodiscovery/config.json' Apr 21 08:16:36 volumio-n1 volumio[4805]: Discovery: StartAdv! undefined Apr 21 08:16:36 volumio-n1 volumio[4805]: Discovery: Started advertising... undefined - undefined Apr 21 08:16:36 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "outputs"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "albumart"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Plugin example_plugin is not enabled Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "inputs"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "updater_comm"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Plugin mpdemulation is not enabled Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "rest_api"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: Loading plugin "websocket"... Apr 21 08:16:36 volumio-n1 volumio[4805]: info: ___________ START PLUGINS ___________ Apr 21 08:16:36 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 08:16:36 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 08:16:36 volumio-n1 volumio[4805]: info: [1745223396934] CoreMusicLibrary::Adding element Media Servers Apr 21 08:16:36 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 08:16:36 volumio-n1 volumio[4805]: Forking 3 albumart workers Apr 21 08:16:37 volumio-n1 volumio[4805]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 08:16:37 volumio-n1 volumio[4805]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 08:16:37 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 08:16:37 volumio-n1 volumio[4805]: info: [1745223397025] CoreMusicLibrary::Adding element Last_100 Apr 21 08:16:37 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 08:16:37 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 08:16:37 volumio-n1 volumio[4805]: info: [1745223397030] CoreMusicLibrary::Adding element Webradio Apr 21 08:16:37 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 08:16:37 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 08:16:37 volumio-n1 volumio[4805]: info: ------------------------------------------- Apr 21 08:16:37 volumio-n1 volumio[4805]: info: ----- MyVolumio plugins startup ---- Apr 21 08:16:37 volumio-n1 volumio[4805]: info: ------------------------------------------- Apr 21 08:16:37 volumio-n1 volumio[4805]: info: Loading plugins from folder /myvolumio/plugins Apr 21 08:16:37 volumio-n1 volumio[4805]: info: Loading plugins from folder /data/myvolumio/plugins Apr 21 08:16:37 volumio-n1 volumio[4805]: info: Loading plugin "cd_controller"... Apr 21 08:16:37 volumio-n1 volumio[4805]: info: Loading plugin "streaming_services"... Apr 21 08:16:37 volumio-n1 ntpd_intres[4738]: DNS 0.debian.pool.ntp.org -> 193.182.111.141 Apr 21 08:16:37 volumio-n1 ntpd_intres[4738]: DNS 1.debian.pool.ntp.org -> 162.159.200.1 Apr 21 08:16:37 volumio-n1 ntpd_intres[4738]: DNS 2.debian.pool.ntp.org -> 193.182.111.12 Apr 21 08:16:37 volumio-n1 ntpd_intres[4738]: DNS 3.debian.pool.ntp.org -> 193.182.111.14 Apr 21 08:16:37 volumio-n1 volumio[4805]: info: Loading plugin "my_volumio"... Apr 21 08:16:37 volumio-n1 volumio[4805]: Starting albumart workers Apr 21 08:16:37 volumio-n1 volumio[4805]: Starting albumart workers Apr 21 08:16:37 volumio-n1 volumio[4805]: Starting albumart workers Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Adding CD REST API Endpoints Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Detecting CD presence Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Streaming services startup Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Starting Streaming Daemon Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Starting MyVolumio Remote Streaming Endpoints Apr 21 08:16:38 volumio-n1 sudo[4980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 21 08:16:38 volumio-n1 sudo[4980]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Loading i18n strings for locale zh Apr 21 08:16:38 volumio-n1 volumio[4805]: Updating browse sources language Apr 21 08:16:38 volumio-n1 volumio[4805]: Cannot find translation for sourceMedia Servers Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 08:16:38 volumio-n1 systemd[1]: Stopping Volumio Streaming Daemon... Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 08:16:38 volumio-n1 systemd[1]: Starting Volumio Streaming Daemon... Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::initPlayerControls Apr 21 08:16:38 volumio-n1 systemd[1]: Started Volumio Streaming Daemon. Apr 21 08:16:38 volumio-n1 sudo[4980]: pam_unix(sudo:session): session closed for user root Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 21 08:16:38 volumio-n1 volumio-streaming-daemon[4983]: ############################ Apr 21 08:16:38 volumio-n1 volumio-streaming-daemon[4983]: # Volumio Streaming Daemon # Apr 21 08:16:38 volumio-n1 volumio-streaming-daemon[4983]: # Running on port 7777 # Apr 21 08:16:38 volumio-n1 volumio-streaming-daemon[4983]: ############################ Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: BOOT COMPLETED Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::Close All Modals sent Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::Close All Modals sent Apr 21 08:16:38 volumio-n1 volumio[4805]: Express server listening on port 3000 Apr 21 08:16:38 volumio-n1 volumio[4805]: Volumio Calling Home Apr 21 08:16:38 volumio-n1 volumio[4805]: info: MyVolumio not started Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Initializing device activation check Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreStateMachine::resetVolumioState Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreStateMachine::getcurrentVolume Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 08:16:38 volumio-n1 volumio[4805]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/plugins.json' Apr 21 08:16:38 volumio-n1 volumio[4805]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json' Apr 21 08:16:38 volumio-n1 volumio[4805]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 21 08:16:38 volumio-n1 volumio[4805]: info: Setting Device type: Amlogic Apr 21 08:16:38 volumio-n1 volumio[4805]: info: MPD running with PID4610 ,establishing connection Apr 21 08:16:38 volumio-n1 sudo[5002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Apr 21 08:16:38 volumio-n1 sudo[5002]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:38 volumio-n1 sudo[5002]: pam_unix(sudo:session): session closed for user root Apr 21 08:16:38 volumio-n1 volumio[4805]: info: VolumeController:: Volume=undefined Mute =false Apr 21 08:16:38 volumio-n1 volumio[4805]: info: CoreStateMachine::pushState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreStateMachine::getState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CorePlayQueue::getTrack 0 Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioPushState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 08:16:39 volumio-n1 volumio[4805]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Apr 21 08:16:39 volumio-n1 volumio[4805]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Apr 21 08:16:39 volumio-n1 volumio[4805]: info: Reloading queue from file Apr 21 08:16:39 volumio-n1 volumio[4805]: info: Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreStateMachine::setRepeat false single undefined Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreStateMachine::pushState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreStateMachine::getState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CorePlayQueue::getTrack 0 Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioPushState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreStateMachine::setRandom true Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreStateMachine::pushState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreStateMachine::getState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CorePlayQueue::getTrack 0 Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioPushState Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 08:16:39 volumio-n1 sudo[5006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Apr 21 08:16:39 volumio-n1 sudo[5006]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:39 volumio-n1 volumio[4805]: { Error: EACCES: permission denied, unlink '/data/backgrounds/aurora.jpg' Apr 21 08:16:39 volumio-n1 volumio[4805]: errno: -13, Apr 21 08:16:39 volumio-n1 volumio[4805]: code: 'EACCES', Apr 21 08:16:39 volumio-n1 volumio[4805]: syscall: 'unlink', Apr 21 08:16:39 volumio-n1 volumio[4805]: path: '/data/backgrounds/aurora.jpg' } Apr 21 08:16:39 volumio-n1 systemd[1]: Starting ShairportSync AirTunes receiver... Apr 21 08:16:39 volumio-n1 systemd[1]: Started ShairportSync AirTunes receiver. Apr 21 08:16:39 volumio-n1 sudo[5009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Apr 21 08:16:39 volumio-n1 sudo[5009]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 08:16:39 volumio-n1 sudo[5006]: pam_unix(sudo:session): session closed for user root Apr 21 08:16:39 volumio-n1 volumio[4805]: info: Shairport-Sync Started Apr 21 08:16:39 volumio-n1 volumio[4805]: Error adding Membership: Error: addMembership EINVAL Apr 21 08:16:39 volumio-n1 shairport-sync[5010]: Successful Startup Apr 21 08:16:39 volumio-n1 systemd[1]: Stopping ShairportSync AirTunes receiver... Apr 21 08:16:39 volumio-n1 systemd[1]: Starting ShairportSync AirTunes receiver... Apr 21 08:16:39 volumio-n1 systemd[1]: Started ShairportSync AirTunes receiver. Apr 21 08:16:39 volumio-n1 sudo[5009]: pam_unix(sudo:session): session closed for user root Apr 21 08:16:39 volumio-n1 volumio[4805]: info: Shairport-Sync Started Apr 21 08:16:39 volumio-n1 shairport-sync[5014]: Successful Startup Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 21 08:16:39 volumio-n1 volumio[4805]: info: Version has changed, forcing UI Reload Apr 21 08:16:39 volumio-n1 volumio[4805]: info: CoreCommandRouter::Reload Ui Apr 21 08:16:40 volumio-n1 volumio[4805]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json' Apr 21 08:16:41 volumio-n1 kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. Apr 21 08:16:43 volumio-n1 volumio[4805]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/my_volumio/config.json' Apr 21 08:16:43 volumio-n1 volumio[4805]: Discovery: ecc TypeError: argument 8 must be an integer (port) Apr 21 08:16:43 volumio-n1 volumio[4805]: Discovery: StartAdv! false Apr 21 08:16:43 volumio-n1 volumio[4805]: Discovery: Started advertising... undefined - false Apr 21 08:16:43 volumio-n1 volumio[4805]: info: CoreCommandRouter::volumioGetState Apr 21 08:16:43 volumio-n1 volumio[4805]: info: CoreStateMachine::getState Apr 21 08:16:43 volumio-n1 volumio[4805]: info: CorePlayQueue::getTrack 0 Apr 21 08:16:43 volumio-n1 volumio[4805]: error: Failed initialization of streaming services: Error: An error occurred while configuring services daemon. Apr 21 08:16:44 volumio-n1 volumio-remote-updater[4559]: [2025-04-21 08:16:44] [connect] Successful connection Apr 21 08:16:44 volumio-n1 volumio-remote-updater[4559]: [2025-04-21 08:16:44] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1745223404 101 Apr 21 08:16:44 volumio-n1 volumio[4805]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 08:16:44 volumio-n1 volumio[4805]: TypeError: Cannot read property 'charAt' of undefined Apr 21 08:16:44 volumio-n1 volumio[4805]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:208:28) Apr 21 08:16:44 volumio-n1 volumio[4805]: at ontimeout (timers.js:482:11) Apr 21 08:16:44 volumio-n1 volumio[4805]: at tryOnTimeout (timers.js:317:5) Apr 21 08:16:44 volumio-n1 volumio[4805]: at Timer.listOnTimeout (timers.js:277:5) Apr 21 08:16:44 volumio-n1 volumio[4805]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 08:16:51 volumio-n1 systemd[1]: Time has been changed Apr 21 08:16:52 volumio-n1 sudo[5032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-21 08:15 Apr 21 08:16:52 volumio-n1 sudo[5032]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7434a810e3a57a07e8ee53a8f2063b5b15d2425c" VOLUMIO_FE_VERSION="8d42aa2ed20c7c37b42519af63b83b0cbcd3af68" VOLUMIO_BE_VERSION="fd4f91711c718295fa83ff62d1b2772d1cb50601" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Sep 3 19:53:55 CEST 2019" VOLUMIO_VERSION="2.603" VOLUMIO_HARDWARE="vim1" VOLUMIO_HASH="b2272113b215eebd4e2ea68b15bca646"